builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1474121998.41 results: success (0) buildid: 20160917004009 builduid: 39c0864104644d618a468a713b19f1a0 revision: b9499912b32324acd84792bf02b533b40e98e496 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:58.414579) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:58.415205) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:58.415516) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:58.430789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:58.431240) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-17 07:19:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.5M=0s 2016-09-17 07:19:58 (38.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111936 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:58.578155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:58.578566) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015015 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:58.640078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:58.640461) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b9499912b32324acd84792bf02b533b40e98e496 --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 b9499912b32324acd84792bf02b533b40e98e496 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-17 07:19:59,051 truncating revision to first 12 chars 2016-09-17 07:19:59,051 Setting DEBUG logging. 2016-09-17 07:19:59,051 attempt 1/10 2016-09-17 07:19:59,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b9499912b323?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-17 07:19:59,435 unpacking tar archive at: mozilla-aurora-b9499912b323/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716434 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:59.371412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:59.371763) ========= script_repo_revision: b9499912b32324acd84792bf02b533b40e98e496 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:59.372250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:59.372556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 07:19:59.382066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-17 07:19:59.382387) ========= /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=14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:19:59 INFO - MultiFileLogger online at 20160917 07:19:59 in /builds/slave/test 07:19:59 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 07:19:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:19:59 INFO - {'append_to_log': False, 07:19:59 INFO - 'base_work_dir': '/builds/slave/test', 07:19:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:19:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:19:59 INFO - 'branch': 'Mozilla-Aurora', 07:19:59 INFO - 'buildbot_json_path': 'buildprops.json', 07:19:59 INFO - 'config_files': ('talos/linux_config.py',), 07:19:59 INFO - 'default_actions': ('clobber', 07:19:59 INFO - 'read-buildbot-config', 07:19:59 INFO - 'download-and-extract', 07:19:59 INFO - 'populate-webroot', 07:19:59 INFO - 'create-virtualenv', 07:19:59 INFO - 'install', 07:19:59 INFO - 'run-tests'), 07:19:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:19:59 INFO - 'download_minidump_stackwalk': True, 07:19:59 INFO - 'download_symbols': 'ondemand', 07:19:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:19:59 INFO - 'tooltool.py': '/tools/tooltool.py', 07:19:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:19:59 INFO - '/tools/misc-python/virtualenv.py')}, 07:19:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:19:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:19:59 INFO - 'installer_path': 'installer.exe', 07:19:59 INFO - 'log_level': 'info', 07:19:59 INFO - 'log_name': 'talos', 07:19:59 INFO - 'log_to_console': True, 07:19:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:19:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:19:59 INFO - 'opt_config_files': (), 07:19:59 INFO - 'pip_index': False, 07:19:59 INFO - 'sps_profile': False, 07:19:59 INFO - 'sps_profile_interval': 0, 07:19:59 INFO - 'suite': 'dromaeojs-e10s', 07:19:59 INFO - 'system_bits': '32', 07:19:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:19:59 INFO - 'title': 'talos-linux64-ix-036', 07:19:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:19:59 INFO - 'use_talos_json': True, 07:19:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:19:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:19:59 INFO - 'work_dir': 'build'} 07:19:59 INFO - [mozharness: 2016-09-17 14:19:59.889478Z] Running clobber step. 07:19:59 INFO - Running pre-action listener: _resource_record_pre_action 07:19:59 INFO - Running main action method: clobber 07:19:59 INFO - rmtree: /builds/slave/test/build 07:19:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:20:00 INFO - Running post-action listener: _resource_record_post_action 07:20:00 INFO - [mozharness: 2016-09-17 14:20:00.369780Z] Finished clobber step (success) 07:20:00 INFO - [mozharness: 2016-09-17 14:20:00.369882Z] Running read-buildbot-config step. 07:20:00 INFO - Running pre-action listener: _resource_record_pre_action 07:20:00 INFO - Running main action method: read_buildbot_config 07:20:00 INFO - Using buildbot properties: 07:20:00 INFO - { 07:20:00 INFO - "project": "", 07:20:00 INFO - "product": "firefox", 07:20:00 INFO - "script_repo_revision": "production", 07:20:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:20:00 INFO - "repository": "", 07:20:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:20:00 INFO - "buildid": "20160917004009", 07:20:00 INFO - "stage_platform": "linux64-pgo", 07:20:00 INFO - "basedir": "/builds/slave/test", 07:20:00 INFO - "nightly_build": "True", 07:20:00 INFO - "buildnumber": 507, 07:20:00 INFO - "slavename": "talos-linux64-ix-036", 07:20:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:20:00 INFO - "platform": "ubuntu64_hw", 07:20:00 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:20:00 INFO - "branch": "mozilla-aurora", 07:20:00 INFO - "repo_path": "releases/mozilla-aurora", 07:20:00 INFO - "revision": "b9499912b32324acd84792bf02b533b40e98e496", 07:20:00 INFO - "pgo_build": "True", 07:20:00 INFO - "builduid": "39c0864104644d618a468a713b19f1a0", 07:20:00 INFO - "slavebuilddir": "test" 07:20:00 INFO - } 07:20:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 07:20:00 INFO - Running post-action listener: _resource_record_post_action 07:20:00 INFO - [mozharness: 2016-09-17 14:20:00.372419Z] Finished read-buildbot-config step (success) 07:20:00 INFO - [mozharness: 2016-09-17 14:20:00.372509Z] Running download-and-extract step. 07:20:00 INFO - Running pre-action listener: _resource_record_pre_action 07:20:00 INFO - Running main action method: download_and_extract 07:20:00 INFO - mkdir: /builds/slave/test/build/tests 07:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:00 INFO - https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:20:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:20:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:20:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:20:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:20:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:20:00 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:20:00 INFO - retry: Failed, sleeping 30 seconds before retrying 07:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:20:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:20:30 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:20:30 INFO - retry: Failed, sleeping 60 seconds before retrying 07:21:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:21:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:21:30 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:21:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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! 07:21:30 INFO - Caught exception: HTTP Error 404: Not Found 07:21:30 INFO - Caught exception: HTTP Error 404: Not Found 07:21:30 INFO - Caught exception: HTTP Error 404: Not Found 07:21:30 INFO - trying https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:21:30 INFO - Downloading https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:21:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:21:31 INFO - Downloaded 1361 bytes. 07:21:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:21:31 INFO - Using the following test package requirements: 07:21:31 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 07:21:31 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:21:31 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:21:31 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:31 INFO - u'jsshell-linux-x86_64.zip'], 07:21:31 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:21:31 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 07:21:31 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:21:31 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:21:31 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:21:31 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:21:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:21:31 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:21: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')]} 07:21:31 INFO - https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:21:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:21:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:21:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:21:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:21:31 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:21:31 INFO - retry: Failed, sleeping 30 seconds before retrying 07:22:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:22:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:22:01 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:22:01 INFO - retry: Failed, sleeping 60 seconds before retrying 07:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:01 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:23:01 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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! 07:23:01 INFO - Caught exception: HTTP Error 404: Not Found 07:23:01 INFO - Caught exception: HTTP Error 404: Not Found 07:23:01 INFO - Caught exception: HTTP Error 404: Not Found 07:23:01 INFO - trying https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:01 INFO - Downloading https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:01 INFO - Downloaded 21771059 bytes. 07:23:01 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'] 07:23:01 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 07:23:03 INFO - Return code: 0 07:23:03 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 07:23:03 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')]} 07:23:03 INFO - https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:23:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:03 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:23:03 INFO - retry: Failed, sleeping 30 seconds before retrying 07:23:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:23:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:23:33 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:23:33 INFO - retry: Failed, sleeping 60 seconds before retrying 07:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:24:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:24:33 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:24:33 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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! 07:24:33 INFO - Caught exception: HTTP Error 404: Not Found 07:24:33 INFO - Caught exception: HTTP Error 404: Not Found 07:24:33 INFO - Caught exception: HTTP Error 404: Not Found 07:24:33 INFO - trying https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:24:33 INFO - Downloading https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:24:34 INFO - Downloaded 21771059 bytes. 07:24:34 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'] 07:24:34 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 07:24:35 INFO - Return code: 0 07:24: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')]} 07:24:35 INFO - https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:24:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:24:35 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:24:35 INFO - retry: Failed, sleeping 30 seconds before retrying 07:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:25:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:25:05 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:25:05 INFO - retry: Failed, sleeping 60 seconds before retrying 07:26:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:26:05 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:26:05 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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! 07:26:05 INFO - Caught exception: HTTP Error 404: Not Found 07:26:05 INFO - Caught exception: HTTP Error 404: Not Found 07:26:05 INFO - Caught exception: HTTP Error 404: Not Found 07:26:05 INFO - trying https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:26:05 INFO - Downloading https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:06 INFO - Downloaded 14413740 bytes. 07:26:06 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'] 07:26:06 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 07:26:06 INFO - Return code: 0 07:26:06 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')]} 07:26:06 INFO - https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:26:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:26:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:26:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:26:06 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:26:06 INFO - retry: Failed, sleeping 30 seconds before retrying 07:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:26:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:26:36 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:26:36 INFO - retry: Failed, sleeping 60 seconds before retrying 07:27:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:27:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:27:36 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:27:36 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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! 07:27:36 INFO - Caught exception: HTTP Error 404: Not Found 07:27:36 INFO - Caught exception: HTTP Error 404: Not Found 07:27:36 INFO - Caught exception: HTTP Error 404: Not Found 07:27:36 INFO - trying https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:27:36 INFO - Downloading https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:27:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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 07:27:37 INFO - Downloaded 63891050 bytes. 07:27:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:27:37 INFO - mkdir: /builds/slave/test/properties 07:27:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:27:37 INFO - Writing to file /builds/slave/test/properties/build_url 07:27:37 INFO - Contents: 07:27:37 INFO - build_url:https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:27:38 INFO - Running post-action listener: _resource_record_post_action 07:27:38 INFO - Running post-action listener: set_extra_try_arguments 07:27:38 INFO - [mozharness: 2016-09-17 14:27:38.534744Z] Finished download-and-extract step (success) 07:27:38 INFO - [mozharness: 2016-09-17 14:27:38.534981Z] Running populate-webroot step. 07:27:38 INFO - Running pre-action listener: _resource_record_pre_action 07:27:38 INFO - Running main action method: populate_webroot 07:27:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:38 INFO - '--tppagecycles', 07:27:38 INFO - '7'], 07:27:38 INFO - 'tests': ['tsvgm']}}, 07:27:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:27:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:27:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:27:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:38 INFO - 'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:38 INFO - 'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['damp', 'tps']}, 07:27:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:38 INFO - 'tests': ['damp', 'tps']}, 07:27:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['dromaeo_dom']}, 07:27:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['basic_compositor_video']}, 07:27:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:27:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['a11yr', 07:27:38 INFO - 'ts_paint', 07:27:38 INFO - 'tpaint', 07:27:38 INFO - 'sessionrestore', 07:27:38 INFO - 'sessionrestore_no_auto_restore', 07:27:38 INFO - 'tabpaint']}, 07:27:38 INFO - 'other-e10s': {'tests': ['a11yr', 07:27:38 INFO - 'ts_paint', 07:27:38 INFO - 'tpaint', 07:27:38 INFO - 'sessionrestore', 07:27:38 INFO - 'sessionrestore_no_auto_restore', 07:27:38 INFO - 'tabpaint']}, 07:27:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:27:38 INFO - 'ts_paint', 07:27:38 INFO - 'tpaint', 07:27:38 INFO - 'sessionrestore', 07:27:38 INFO - 'sessionrestore_no_auto_restore', 07:27:38 INFO - 'tabpaint']}, 07:27:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:27:38 INFO - 'ts_paint', 07:27:38 INFO - 'tpaint', 07:27:38 INFO - 'sessionrestore', 07:27:38 INFO - 'sessionrestore_no_auto_restore', 07:27:38 INFO - 'tabpaint']}, 07:27:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['a11yr', 07:27:38 INFO - 'ts_paint', 07:27:38 INFO - 'tpaint', 07:27:38 INFO - 'sessionrestore', 07:27:38 INFO - 'sessionrestore_no_auto_restore', 07:27:38 INFO - 'tabpaint']}, 07:27:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['a11yr', 07:27:38 INFO - 'ts_paint', 07:27:38 INFO - 'tpaint', 07:27:38 INFO - 'sessionrestore', 07:27:38 INFO - 'sessionrestore_no_auto_restore', 07:27:38 INFO - 'tabpaint']}, 07:27:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['tsvgx', 07:27:38 INFO - 'tsvgr_opacity', 07:27:38 INFO - 'tart', 07:27:38 INFO - 'tscrollx', 07:27:38 INFO - 'cart']}, 07:27:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:27:38 INFO - 'tsvgr_opacity', 07:27:38 INFO - 'tart', 07:27:38 INFO - 'tscrollx', 07:27:38 INFO - 'cart']}, 07:27:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:38 INFO - 'talos_options': ['--disable-e10s'], 07:27:38 INFO - 'tests': ['tp5o']}, 07:27:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:38 INFO - 'tests': ['tp5o']}, 07:27:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:38 INFO - 'talos_options': ['--disable-e10s', 07:27:38 INFO - '--xperf_path', 07:27:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:38 INFO - 'tests': ['tp5n']}, 07:27:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:38 INFO - 'talos_options': ['--xperf_path', 07:27:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:38 INFO - 'tests': ['tp5n']}}, 07:27:38 INFO - 'talos.zip': {'path': '', 07:27:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:38 INFO - Running post-action listener: _resource_record_post_action 07:27:38 INFO - [mozharness: 2016-09-17 14:27:38.554953Z] Finished populate-webroot step (success) 07:27:38 INFO - [mozharness: 2016-09-17 14:27:38.555043Z] Running create-virtualenv step. 07:27:38 INFO - Running pre-action listener: _resource_record_pre_action 07:27:38 INFO - Running main action method: create_virtualenv 07:27:38 INFO - Creating virtualenv /builds/slave/test/build/venv 07:27:38 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 07:27:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:27:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:38 INFO - Using real prefix '/usr' 07:27:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:27:39 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:41 INFO - Installing pip.................done. 07:27:41 INFO - Return code: 0 07:27:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:27:41 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')]} 07:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:41 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')]} 07:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:41 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 0x1e42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2071400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', '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 07:27:41 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 07:27:41 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 07:27:41 INFO - Using env: {'DISPLAY': ':0', 07:27:41 INFO - 'HOME': '/home/cltbld', 07:27:41 INFO - 'LANG': 'en_US.UTF-8', 07:27:41 INFO - 'LANGUAGE': 'en_US:en', 07:27:41 INFO - 'LOGNAME': 'cltbld', 07:27:41 INFO - 'MAIL': '/var/mail/cltbld', 07:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:41 INFO - 'MOZ_NO_REMOTE': '1', 07:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:41 INFO - 'NO_EM_RESTART': '1', 07:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:41 INFO - 'PWD': '/builds/slave/test', 07:27:41 INFO - 'SHELL': '/bin/bash', 07:27:41 INFO - 'SHLVL': '1', 07:27:41 INFO - 'TERM': 'linux', 07:27:41 INFO - 'TMOUT': '86400', 07:27:41 INFO - 'USER': 'cltbld', 07:27:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:41 INFO - '_': '/tools/buildbot/bin/python'} 07:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:41 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 07:27:41 INFO - Cleaning up... 07:27:41 INFO - Return code: 0 07:27:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:27:41 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')]} 07:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:41 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')]} 07:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:41 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 0x1e42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2071400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', '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 07:27:41 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 07:27:41 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 07:27:41 INFO - Using env: {'DISPLAY': ':0', 07:27:41 INFO - 'HOME': '/home/cltbld', 07:27:41 INFO - 'LANG': 'en_US.UTF-8', 07:27:41 INFO - 'LANGUAGE': 'en_US:en', 07:27:41 INFO - 'LOGNAME': 'cltbld', 07:27:41 INFO - 'MAIL': '/var/mail/cltbld', 07:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:41 INFO - 'MOZ_NO_REMOTE': '1', 07:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:41 INFO - 'NO_EM_RESTART': '1', 07:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:41 INFO - 'PWD': '/builds/slave/test', 07:27:41 INFO - 'SHELL': '/bin/bash', 07:27:41 INFO - 'SHLVL': '1', 07:27:41 INFO - 'TERM': 'linux', 07:27:41 INFO - 'TMOUT': '86400', 07:27:41 INFO - 'USER': 'cltbld', 07:27:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:41 INFO - '_': '/tools/buildbot/bin/python'} 07:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:41 INFO - Downloading/unpacking psutil>=3.1.1 07:27:41 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 07:27:41 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 07:27:41 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 07:27:41 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 07:27:41 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 07:27:41 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 07:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:27:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:43 INFO - Installing collected packages: psutil 07:27:43 INFO - Running setup.py install for psutil 07:27:43 INFO - building 'psutil._psutil_linux' extension 07:27:43 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 07:27:43 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 07:27:43 INFO - building 'psutil._psutil_posix' extension 07:27:43 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 07:27:43 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 07:27:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:44 INFO - Successfully installed psutil 07:27:44 INFO - Cleaning up... 07:27:44 INFO - Return code: 0 07:27:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2071400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', '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 07:27:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:27:44 INFO - Using env: {'DISPLAY': ':0', 07:27:44 INFO - 'HOME': '/home/cltbld', 07:27:44 INFO - 'LANG': 'en_US.UTF-8', 07:27:44 INFO - 'LANGUAGE': 'en_US:en', 07:27:44 INFO - 'LOGNAME': 'cltbld', 07:27:44 INFO - 'MAIL': '/var/mail/cltbld', 07:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:44 INFO - 'MOZ_NO_REMOTE': '1', 07:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:44 INFO - 'NO_EM_RESTART': '1', 07:27:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:44 INFO - 'PWD': '/builds/slave/test', 07:27:44 INFO - 'SHELL': '/bin/bash', 07:27:44 INFO - 'SHLVL': '1', 07:27:44 INFO - 'TERM': 'linux', 07:27:44 INFO - 'TMOUT': '86400', 07:27:44 INFO - 'USER': 'cltbld', 07:27:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:44 INFO - '_': '/tools/buildbot/bin/python'} 07:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:27:46 INFO - Installing collected packages: mozsystemmonitor 07:27:46 INFO - Running setup.py install for mozsystemmonitor 07:27:46 INFO - Successfully installed mozsystemmonitor 07:27:46 INFO - Cleaning up... 07:27:46 INFO - Return code: 0 07:27:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2071400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', '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 07:27:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:27:46 INFO - Using env: {'DISPLAY': ':0', 07:27:46 INFO - 'HOME': '/home/cltbld', 07:27:46 INFO - 'LANG': 'en_US.UTF-8', 07:27:46 INFO - 'LANGUAGE': 'en_US:en', 07:27:46 INFO - 'LOGNAME': 'cltbld', 07:27:46 INFO - 'MAIL': '/var/mail/cltbld', 07:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:46 INFO - 'MOZ_NO_REMOTE': '1', 07:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:46 INFO - 'NO_EM_RESTART': '1', 07:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:46 INFO - 'PWD': '/builds/slave/test', 07:27:46 INFO - 'SHELL': '/bin/bash', 07:27:46 INFO - 'SHLVL': '1', 07:27:46 INFO - 'TERM': 'linux', 07:27:46 INFO - 'TMOUT': '86400', 07:27:46 INFO - 'USER': 'cltbld', 07:27:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:46 INFO - '_': '/tools/buildbot/bin/python'} 07:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:46 INFO - Downloading/unpacking jsonschema==2.5.1 07:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:27:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:48 INFO - Downloading functools32-3.2.3-2.tar.gz 07:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:27:48 INFO - warning: no files found matching '*.txt' 07:27:48 INFO - no previously-included directories found matching 'build' 07:27:48 INFO - no previously-included directories found matching 'dist' 07:27:48 INFO - no previously-included directories found matching '.git*' 07:27:48 INFO - Installing collected packages: jsonschema, functools32 07:27:48 INFO - Running setup.py install for functools32 07:27:48 INFO - warning: no files found matching '*.txt' 07:27:48 INFO - no previously-included directories found matching 'build' 07:27:48 INFO - no previously-included directories found matching 'dist' 07:27:48 INFO - no previously-included directories found matching '.git*' 07:27:48 INFO - Successfully installed jsonschema functools32 07:27:48 INFO - Cleaning up... 07:27:48 INFO - Return code: 0 07:27:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2071400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', '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 07:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:27:48 INFO - Using env: {'DISPLAY': ':0', 07:27:48 INFO - 'HOME': '/home/cltbld', 07:27:48 INFO - 'LANG': 'en_US.UTF-8', 07:27:48 INFO - 'LANGUAGE': 'en_US:en', 07:27:48 INFO - 'LOGNAME': 'cltbld', 07:27:48 INFO - 'MAIL': '/var/mail/cltbld', 07:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:48 INFO - 'MOZ_NO_REMOTE': '1', 07:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:48 INFO - 'NO_EM_RESTART': '1', 07:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:48 INFO - 'PWD': '/builds/slave/test', 07:27:48 INFO - 'SHELL': '/bin/bash', 07:27:48 INFO - 'SHLVL': '1', 07:27:48 INFO - 'TERM': 'linux', 07:27:48 INFO - 'TMOUT': '86400', 07:27:48 INFO - 'USER': 'cltbld', 07:27:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:48 INFO - '_': '/tools/buildbot/bin/python'} 07:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:27:49 INFO - Cleaning up... 07:27:49 INFO - Return code: 0 07:27:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2071400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', '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 07:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:27:49 INFO - Using env: {'DISPLAY': ':0', 07:27:49 INFO - 'HOME': '/home/cltbld', 07:27:49 INFO - 'LANG': 'en_US.UTF-8', 07:27:49 INFO - 'LANGUAGE': 'en_US:en', 07:27:49 INFO - 'LOGNAME': 'cltbld', 07:27:49 INFO - 'MAIL': '/var/mail/cltbld', 07:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:49 INFO - 'MOZ_NO_REMOTE': '1', 07:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:49 INFO - 'NO_EM_RESTART': '1', 07:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:49 INFO - 'PWD': '/builds/slave/test', 07:27:49 INFO - 'SHELL': '/bin/bash', 07:27:49 INFO - 'SHLVL': '1', 07:27:49 INFO - 'TERM': 'linux', 07:27:49 INFO - 'TMOUT': '86400', 07:27:49 INFO - 'USER': 'cltbld', 07:27:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:49 INFO - '_': '/tools/buildbot/bin/python'} 07:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:49 INFO - Downloading/unpacking blobuploader==1.2.4 07:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:51 INFO - Downloading blobuploader-1.2.4.tar.gz 07:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:27:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:27:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:51 INFO - Downloading docopt-0.6.1.tar.gz 07:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:27:52 INFO - Installing collected packages: blobuploader, requests, docopt 07:27:52 INFO - Running setup.py install for blobuploader 07:27:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:27:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:27:52 INFO - Running setup.py install for requests 07:27:52 INFO - Running setup.py install for docopt 07:27:52 INFO - Successfully installed blobuploader requests docopt 07:27:52 INFO - Cleaning up... 07:27:52 INFO - Return code: 0 07:27:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2071400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', '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 07:27:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:27:52 INFO - Using env: {'DISPLAY': ':0', 07:27:52 INFO - 'HOME': '/home/cltbld', 07:27:52 INFO - 'LANG': 'en_US.UTF-8', 07:27:52 INFO - 'LANGUAGE': 'en_US:en', 07:27:52 INFO - 'LOGNAME': 'cltbld', 07:27:52 INFO - 'MAIL': '/var/mail/cltbld', 07:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:52 INFO - 'MOZ_NO_REMOTE': '1', 07:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:52 INFO - 'NO_EM_RESTART': '1', 07:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:52 INFO - 'PWD': '/builds/slave/test', 07:27:52 INFO - 'SHELL': '/bin/bash', 07:27:52 INFO - 'SHLVL': '1', 07:27:52 INFO - 'TERM': 'linux', 07:27:52 INFO - 'TMOUT': '86400', 07:27:52 INFO - 'USER': 'cltbld', 07:27:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:52 INFO - '_': '/tools/buildbot/bin/python'} 07:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:52 INFO - Running setup.py (path:/tmp/pip-s8dsyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:52 INFO - Running setup.py (path:/tmp/pip-h0u0Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:53 INFO - Running setup.py (path:/tmp/pip-nww_sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:53 INFO - Running setup.py (path:/tmp/pip-Ax8BfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:53 INFO - Running setup.py (path:/tmp/pip-c88WKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:53 INFO - Running setup.py (path:/tmp/pip-wv7pCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:53 INFO - Running setup.py (path:/tmp/pip-EokyIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:53 INFO - Running setup.py (path:/tmp/pip-YmGizB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:53 INFO - Running setup.py (path:/tmp/pip-rnWmPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:53 INFO - Running setup.py (path:/tmp/pip-lR1aj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:53 INFO - Running setup.py (path:/tmp/pip-2qwKDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:53 INFO - Running setup.py (path:/tmp/pip-UCIqhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:53 INFO - Running setup.py (path:/tmp/pip-mJs4qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:53 INFO - Running setup.py (path:/tmp/pip-b6AeSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:53 INFO - Running setup.py (path:/tmp/pip-RTgVAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:53 INFO - Running setup.py (path:/tmp/pip-cTisZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:54 INFO - Running setup.py (path:/tmp/pip-W9TuVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:27:54 INFO - Running setup.py install for manifestparser 07:27:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:27:54 INFO - Running setup.py install for mozcrash 07:27:54 INFO - Running setup.py install for mozdebug 07:27:54 INFO - Running setup.py install for mozdevice 07:27:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:27:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:27:54 INFO - Running setup.py install for mozfile 07:27:54 INFO - Running setup.py install for mozhttpd 07:27:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:27:54 INFO - Running setup.py install for mozinfo 07:27:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:27:54 INFO - Running setup.py install for mozInstall 07:27:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:27:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:27:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:27:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:27:54 INFO - Running setup.py install for mozleak 07:27:54 INFO - Running setup.py install for mozlog 07:27:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:27:55 INFO - Running setup.py install for moznetwork 07:27:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:27:55 INFO - Running setup.py install for mozprocess 07:27:55 INFO - Running setup.py install for mozprofile 07:27:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:27:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:27:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:27:55 INFO - Running setup.py install for mozrunner 07:27:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:27:55 INFO - Running setup.py install for mozscreenshot 07:27:55 INFO - Running setup.py install for moztest 07:27:55 INFO - Running setup.py install for mozversion 07:27:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:27:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:27:55 INFO - Cleaning up... 07:27:55 INFO - Return code: 0 07:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2071400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', '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 07:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:27:55 INFO - Using env: {'DISPLAY': ':0', 07:27:55 INFO - 'HOME': '/home/cltbld', 07:27:55 INFO - 'LANG': 'en_US.UTF-8', 07:27:55 INFO - 'LANGUAGE': 'en_US:en', 07:27:55 INFO - 'LOGNAME': 'cltbld', 07:27:55 INFO - 'MAIL': '/var/mail/cltbld', 07:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:55 INFO - 'MOZ_NO_REMOTE': '1', 07:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:55 INFO - 'NO_EM_RESTART': '1', 07:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:55 INFO - 'PWD': '/builds/slave/test', 07:27:55 INFO - 'SHELL': '/bin/bash', 07:27:55 INFO - 'SHLVL': '1', 07:27:55 INFO - 'TERM': 'linux', 07:27:55 INFO - 'TMOUT': '86400', 07:27:55 INFO - 'USER': 'cltbld', 07:27:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:55 INFO - '_': '/tools/buildbot/bin/python'} 07:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:56 INFO - Running setup.py (path:/tmp/pip-ya_ffh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:56 INFO - Running setup.py (path:/tmp/pip-VmuAJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:56 INFO - Running setup.py (path:/tmp/pip-iRW5lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:56 INFO - Running setup.py (path:/tmp/pip-uOfSSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:56 INFO - Running setup.py (path:/tmp/pip-8Q8wdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:56 INFO - Running setup.py (path:/tmp/pip-yS23mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:56 INFO - Running setup.py (path:/tmp/pip-CDm1QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:56 INFO - Running setup.py (path:/tmp/pip-R45KEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:56 INFO - Running setup.py (path:/tmp/pip-oNjo8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:56 INFO - Running setup.py (path:/tmp/pip-mKOSUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:56 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)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:56 INFO - Running setup.py (path:/tmp/pip-IaQbAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:56 INFO - Running setup.py (path:/tmp/pip-DJTdI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:56 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)) 07:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:57 INFO - Running setup.py (path:/tmp/pip-nAcGJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:57 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)) 07:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:57 INFO - Running setup.py (path:/tmp/pip-R1FruF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:57 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)) 07:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:57 INFO - Running setup.py (path:/tmp/pip-uVvIje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:57 INFO - Running setup.py (path:/tmp/pip-6z3wig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:57 INFO - Running setup.py (path:/tmp/pip-KR8nJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:27:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:59 INFO - Downloading blessings-1.6.tar.gz 07:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:27:59 INFO - Installing collected packages: blessings 07:27:59 INFO - Running setup.py install for blessings 07:27:59 INFO - Successfully installed blessings 07:27:59 INFO - Cleaning up... 07:27:59 INFO - Return code: 0 07:27:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:27:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:59 INFO - Reading from file tmpfile_stdout 07:27:59 INFO - Current package versions: 07:27:59 INFO - argparse == 1.2.1 07:27:59 INFO - blessings == 1.6 07:27:59 INFO - blobuploader == 1.2.4 07:27:59 INFO - docopt == 0.6.1 07:27:59 INFO - functools32 == 3.2.3-2 07:27:59 INFO - jsonschema == 2.5.1 07:27:59 INFO - manifestparser == 1.1 07:27:59 INFO - mozInstall == 1.12 07:27:59 INFO - mozcrash == 0.17 07:27:59 INFO - mozdebug == 0.1 07:27:59 INFO - mozdevice == 0.48 07:27:59 INFO - mozfile == 1.2 07:27:59 INFO - mozhttpd == 0.7 07:27:59 INFO - mozinfo == 0.9 07:27:59 INFO - mozleak == 0.1 07:27:59 INFO - mozlog == 3.3 07:27:59 INFO - moznetwork == 0.27 07:27:59 INFO - mozprocess == 0.23 07:27:59 INFO - mozprofile == 0.28 07:27:59 INFO - mozrunner == 6.12 07:27:59 INFO - mozscreenshot == 0.1 07:27:59 INFO - mozsystemmonitor == 0.3 07:27:59 INFO - moztest == 0.7 07:27:59 INFO - mozversion == 1.4 07:27:59 INFO - psutil == 3.1.1 07:27:59 INFO - requests == 1.2.3 07:27:59 INFO - wsgiref == 0.1.2 07:27:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2071400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', '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 07:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:27:59 INFO - Using env: {'DISPLAY': ':0', 07:27:59 INFO - 'HOME': '/home/cltbld', 07:27:59 INFO - 'LANG': 'en_US.UTF-8', 07:27:59 INFO - 'LANGUAGE': 'en_US:en', 07:27:59 INFO - 'LOGNAME': 'cltbld', 07:27:59 INFO - 'MAIL': '/var/mail/cltbld', 07:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:59 INFO - 'MOZ_NO_REMOTE': '1', 07:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:59 INFO - 'NO_EM_RESTART': '1', 07:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:59 INFO - 'PWD': '/builds/slave/test', 07:27:59 INFO - 'SHELL': '/bin/bash', 07:27:59 INFO - 'SHLVL': '1', 07:27:59 INFO - 'TERM': 'linux', 07:27:59 INFO - 'TMOUT': '86400', 07:27:59 INFO - 'USER': 'cltbld', 07:27:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:59 INFO - '_': '/tools/buildbot/bin/python'} 07:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:27:59 INFO - Cleaning up... 07:27:59 INFO - Return code: 0 07:27:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2071400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', '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 07:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:27:59 INFO - Using env: {'DISPLAY': ':0', 07:27:59 INFO - 'HOME': '/home/cltbld', 07:27:59 INFO - 'LANG': 'en_US.UTF-8', 07:27:59 INFO - 'LANGUAGE': 'en_US:en', 07:27:59 INFO - 'LOGNAME': 'cltbld', 07:27:59 INFO - 'MAIL': '/var/mail/cltbld', 07:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:59 INFO - 'MOZ_NO_REMOTE': '1', 07:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:59 INFO - 'NO_EM_RESTART': '1', 07:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:59 INFO - 'PWD': '/builds/slave/test', 07:27:59 INFO - 'SHELL': '/bin/bash', 07:27:59 INFO - 'SHLVL': '1', 07:27:59 INFO - 'TERM': 'linux', 07:27:59 INFO - 'TMOUT': '86400', 07:27:59 INFO - 'USER': 'cltbld', 07:27:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:59 INFO - '_': '/tools/buildbot/bin/python'} 07:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:28:00 INFO - Cleaning up... 07:28:00 INFO - Return code: 0 07:28:00 INFO - Running post-action listener: _resource_record_post_action 07:28:00 INFO - Running post-action listener: _start_resource_monitoring 07:28:00 INFO - Starting resource monitoring. 07:28:00 INFO - [mozharness: 2016-09-17 14:28:00.196306Z] Finished create-virtualenv step (success) 07:28:00 INFO - [mozharness: 2016-09-17 14:28:00.196774Z] Running install step. 07:28:00 INFO - Running pre-action listener: _resource_record_pre_action 07:28:00 INFO - Running main action method: install 07:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:00 INFO - Reading from file tmpfile_stdout 07:28:00 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:00 INFO - Reading from file tmpfile_stdout 07:28:00 INFO - Output received: 07:28:00 INFO - Usage: mozinstall [options] installer 07:28:00 INFO - Options: 07:28:00 INFO - -h, --help show this help message and exit 07:28:00 INFO - -d DEST, --destination=DEST 07:28:00 INFO - Directory to install application into. [default: 07:28:00 INFO - "/builds/slave/test"] 07:28:00 INFO - --app=APP Application being installed. [default: firefox] 07:28:00 INFO - mkdir: /builds/slave/test/build/application 07:28:00 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'] 07:28:00 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 07:28:17 INFO - Reading from file tmpfile_stdout 07:28:17 INFO - Output received: 07:28:17 INFO - /builds/slave/test/build/application/firefox/firefox 07:28:17 INFO - Running post-action listener: _resource_record_post_action 07:28:17 INFO - [mozharness: 2016-09-17 14:28:17.377453Z] Finished install step (success) 07:28:17 INFO - [mozharness: 2016-09-17 14:28:17.377736Z] Running run-tests step. 07:28:17 INFO - Running pre-action listener: _resource_record_pre_action 07:28:17 INFO - Running main action method: run_tests 07:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:17 INFO - Python 2.7.3 07:28:17 INFO - Return code: 0 07:28:17 INFO - grabbing minidump binary from tooltool 07:28: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')]} 07:28:17 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 0x2100570>, '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 0x2101470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2101900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:17 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 07:28:17 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 07:28:17 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 07:28:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:17 INFO - Return code: 0 07:28:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:28:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:28:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:17 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/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:28:17 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/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:28:17 INFO - Using env: {'DISPLAY': ':0', 07:28:17 INFO - 'HOME': '/home/cltbld', 07:28:17 INFO - 'LANG': 'en_US.UTF-8', 07:28:17 INFO - 'LANGUAGE': 'en_US:en', 07:28:17 INFO - 'LOGNAME': 'cltbld', 07:28:17 INFO - 'MAIL': '/var/mail/cltbld', 07:28:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:17 INFO - 'MOZ_NO_REMOTE': '1', 07:28:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:17 INFO - 'NO_EM_RESTART': '1', 07:28:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:17 INFO - 'PWD': '/builds/slave/test', 07:28:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:17 INFO - 'SHELL': '/bin/bash', 07:28:17 INFO - 'SHLVL': '1', 07:28:17 INFO - 'TERM': 'linux', 07:28:17 INFO - 'TMOUT': '86400', 07:28:17 INFO - 'USER': 'cltbld', 07:28:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499', 07:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:17 INFO - '_': '/tools/buildbot/bin/python'} 07:28:17 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/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:28:17 INFO - mozversion application_buildid: 20160917004009 07:28:17 INFO - mozversion application_changeset: b9499912b32324acd84792bf02b533b40e98e496 07:28:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:28:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:17 INFO - mozversion application_name: Firefox 07:28:17 INFO - mozversion application_remotingname: firefox-dev 07:28:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:28:17 INFO - mozversion application_vendor: Mozilla 07:28:17 INFO - mozversion application_version: 50.0a2 07:28:17 INFO - mozversion platform_buildid: 20160917004009 07:28:17 INFO - mozversion platform_changeset: b9499912b32324acd84792bf02b533b40e98e496 07:28:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:28:17 INFO - mozversion platform_version: 50.0a2 07:28:17 INFO - using testdate: 1474122497 07:28:17 INFO - actual date: 1474122497 07:28:17 INFO - starting webserver on 'localhost:32808' 07:28:17 INFO - SUITE-START | Running 2 tests 07:28:17 INFO - TEST-START | dromaeo_css 07:28:17 INFO - operating with platform_type : linux_ 07:28:17 INFO - Initialising browser for dromaeo_css test... 07:28:17 INFO - TEST-INFO | started process 15547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiNNHm0/profile http://localhost:32808/getInfo.html) 07:28:22 INFO - PROCESS | 15547 | __metrics Screen width/height:1600/1200 07:28:22 INFO - PROCESS | 15547 | colorDepth:24 07:28:22 INFO - PROCESS | 15547 | Browser inner width/height: 1024/697 07:28:22 INFO - PROCESS | 15547 | __metrics 07:28:23 ERROR - PROCESS | 15547 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:28:24 INFO - TEST-INFO | 15547: exit 0 07:28:24 INFO - Browser initialized. 07:28:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:28:24 INFO - TEST-INFO | started process 15671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiNNHm0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:35 INFO - PROCESS | 15671 | RSS: Main: 153276416 07:28:35 INFO - PROCESS | 15671 | 07:29:25 INFO - PROCESS | 15671 | 1474122565466 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] 07:31:33 INFO - PROCESS | 15671 | Cycle 1(1): loaded http://localhost:32808/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32808/tests/dromaeo/cssquery-ext.html) 07:31:35 INFO - PROCESS | 15671 | RSS: Main: 159469568 07:31:35 INFO - PROCESS | 15671 | 07:34:37 INFO - PROCESS | 15671 | Cycle 1(1): loaded http://localhost:32808/tests/dromaeo/cssquery-ext.html (next: http://localhost:32808/tests/dromaeo/cssquery-jquery.html) 07:34:37 INFO - PROCESS | 15671 | RSS: Main: 155975680 07:34:37 INFO - PROCESS | 15671 | 07:37:39 INFO - PROCESS | 15671 | Cycle 1(1): loaded http://localhost:32808/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32808/tests/dromaeo/cssquery-mootools.html) 07:37:40 INFO - PROCESS | 15671 | RSS: Main: 156459008 07:37:40 INFO - PROCESS | 15671 | 07:40:41 INFO - PROCESS | 15671 | Cycle 1(1): loaded http://localhost:32808/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32808/tests/dromaeo/cssquery-prototype.html) 07:40:42 INFO - PROCESS | 15671 | RSS: Main: 155025408 07:40:42 INFO - PROCESS | 15671 | 07:43:44 INFO - PROCESS | 15671 | Cycle 1(1): loaded http://localhost:32808/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32808/tests/dromaeo/cssquery-yui.html) 07:43:45 INFO - PROCESS | 15671 | RSS: Main: 157474816 07:43:45 INFO - PROCESS | 15671 | 07:46:48 INFO - PROCESS | 15671 | Cycle 1(1): loaded http://localhost:32808/tests/dromaeo/cssquery-yui.html (next: http://localhost:32808/tests/dromaeo/cssquery-dojo.html) 07:46:48 INFO - PROCESS | 15671 | RSS: Main: 158285824 07:46:48 INFO - PROCESS | 15671 | 07:46:48 INFO - PROCESS | 15671 | __start_tp_report 07:46:48 INFO - PROCESS | 15671 | _x_x_mozilla_page_load 07:46:48 INFO - PROCESS | 15671 | _x_x_mozilla_page_load_details 07:46:48 INFO - PROCESS | 15671 | |i|pagename|runs| 07:46:48 INFO - PROCESS | 15671 | |0;dojo.html;3253.5607692961444;3261.494468357404;3274.083256688127;3286.6220384655758;3318.7842790218633;5742.598018138732;5758.7408566614495;5782.248307719996;5847.26909136358;5863.208466856973;5823.388544202861;5826;5925.31858836234;5933.13969474427;5938.7624495020145;5336.839894803162;5388.164834450647;5436.700981446019;5457.590680698943;5467.644603100805;5178.48215178481;5226.7909283628605;5268.025415298182;5330.387005494379;5366.838994830161;5328.973355133219;5373.382061062989;5402.216678581603;5429.158480435519;5476.7535460904155;5441.809536666197;5444.101723215645;5445.809396671137;5447.45525447456;5450.591205659572;5225.843224703265;5233.685978841282;5283.577313814885;5371.650842695212;5466.180072989044;5759.856003599902;5786.392428794958;5803.071508558653;5836.182934389189;5852.619579727304;6273.466755325803;6322.399372059647;6331.525135614847;6343.302236753953;6349.952257877445;6121.422488707842;6223.3776622337855;6345.619262844198;6362.77730279438;6385.425311721968;5850.976079186125;5907.054871220627;5946.8810623787285;5947.316058653267;5987.6108052976415;6447.226332839996;6457.1282876811965;6510.25132109804;6518.152640156749;6523.021546768023;5997.730102145414;6073.696315184311;6229.034499652561;6241.095041218998;6248.375162483806;6146.262448506208;6231.065340199007;6275.843103922347;6286.119943207955;6295.181626388632;6196.628202307876;6215.285242197205;6221.222347206599;6233.283172435137;6257.812265632038;6015.729292181863;6104.4505994460715;6214.751409943642;6259.906101408483;6270.090836828635;4658.34783130362;4715.269133284346;4722.763861806896;4736.194846876039;4749.430068391815;4189.392538081961;4194.2869712149;4194.517630472474;4211.389348544444;4221.092465120014;5813.593048486566;5850.180974663551;5930.733117009745;5959.463648271676;5975.551833612496;6133.3866613339205;6176.907346389808;6187.566870319124;6197.659128747872;6214.5960512566535;5923.259592550931;5929.318128415288;5939.613925094855;5943.821685349447;5944.346121926585;4982.576480999156;4986.601071914238;4995.275685025651;5003.54968052877;5034.16936205522;6470.708818103197;6507.577007494498;6542.869142617121;6548.541602087808;6572.86854262912;6199.3490683477585;6270.529710271657;6319.557630965972;6326.936730632635;6335.714892829926;6269.623822570478;6298.401651843067;6357.364263573606;6538.1500404947055;6562.048502967138;6098.420650038239;6105.8836979267135;6114.266288045463;6121.418465245794;6126.5098792097415;6191.628502289877;6232.54841647876;6235.376462353728;6257.4994000480765;6264.812055638338;5924.822255332347;6026.668533230714;6036.879262414815;6079.696015199311;6092.725827337869;6087.634741915499;6095.2685677718955;6107.511399087974;6128.142060111499;6136.079588061648;6057.969710151598;6095.1771510845465;6102.145699601971;6111.5110791137495;6125.509959203342;6016.368281330398;6052.969735151296;6087.269527656709;6116.29662588808;6155.384461553809;5988.520918326436;6002.369751176064;6011.87976240464;6012.518998480024;6030.698465076816 07:46:48 INFO - PROCESS | 15671 | |1;ext.html;582.8571999860035;625.6027422586658;633.3508154142002;653.5686446945017;674.7503423733219;41470;46248.76875615617;46607.30089048663;46628.067438651204;46698.06603867921;46265.76867115668;46660;46701.53298467014;46705.766471167684;46987;9190;9258.583363748647;9281.860772088425;9293.303002274823;9317.95341023294;9072.682456114037;9110.544472776368;9139.908600914005;9220.30847686423;9230.492322922237;9236.353455258135;9353.298502612297;9369.859452108223;9382.765430864249;9401.294902882277;9226.815463690722;9275.814483710355;9287.674931377403;9291.117343852356;9307.255419566418;9232.215261702764;9253.814923701555;9269.536523173882;9338.533073346374;9366.391184572982;44869.551304486864;44930.32604510935;45010.32484512735;45169.774151129364;45245.32132018022;3976.920461590781;4013.6387725104883;4158.272302347077;4329.012901884288;4523.932141017887;35415.64584354149;35620.28759424823;35793.1051723709;36829.44755828665;37471.81264093662;4663.764102512803;4684;4715.245560710304;4809.206480930678;4917.286993385939;553229;561724;562267;562971;564522;66783;67778.66110669416;67948;68286.65856670684;68416;39988.200235995115;72835;73016.26983730201;73372.26627733654;73381.26618733851;17875.106244687715;18405.355812546764;18461.446156615322;18559.628807424047;18571.44285671432;14326.57020289393;14499.420023198954;14546;14603;14619.122852628876;20983.16067357319;21334.35996920095;21457.67813482799;21464.78535214659;21592.35222943314;7573.848523029508;7623.733169339046;7767.417443691746;7835.255650713173;7948.801279968047;1051.2063392138887;1052.2634156090767;1140.6007897235902;1183.7691650128143;1212.9454174562165;35161.648383515836;35216.29567408689;35360.82319588437;35846.64153358433;36098.27803443969;1152.521703493041;1266.7909794883742;1270.720441502868;1270.7585558743808;1321.359140816703;18437.815621843878;18918.243270269035;18961.810381896004;19329.80670193308;20719.792802072086;661193;663348;666265;667350;669450;65033;65851.67074164598;66027.33972660308;66088.33911660821;66198.66900665466;1469.2727100085312;1484.5917372722588;1507.4648499782638;1516.0600427734655;1517.6661134550382;36218.63781362153;36698.633013669525;36839.81580092083;37461.4380784283;37637.87086387413;59043.114353283876;59657;59791.20626381216;59954.40045599663;60015;415802;417867;418268;418299;541114;31640.525392118678;31957.520637190926;32109.51835722419;32507.187320316236;32842.343153137284;53212.20181697355;53643;53745.387638370914;53939;54387.72806135944;37964.43053354147;38462;45260.77369613262;47992;48167;46988.05405378416;47081.529184709085;47139.764301179646;47341.526584733714;47668.7616561915;45982.77008614936;46790.93994791136;47048.529514705784;47439.762801185774;47675.28487072766;37968.620313796506;41519;41921.58078419177;42428;42965.35551966786;31045.379092418476;31642;31691.04926852198;31805.840970794998;32074.518882216318 07:46:48 INFO - PROCESS | 15671 | |2;jquery.html;425.6063141594025;429.6298461223716;433.79828379803394;435.80388825028734;441.3798612948806;19299.228030878767;20437.080331385107;20979.370618881458;21057.57884842306;21103.894480527593;19391.612167756637;19669;20094;20354;20382;5802.738876750545;6053.576249662526;6056.878862422749;6070.514358851281;6073.63558186508;5885.234919460486;5896.292444906596;5913.704314784265;5964.761409543613;5969.283685957691;5900.675462849542;5916.083007133901;5918.852028699295;5930.822075337725;5938.138969849391;5883.8529036774;5908;5932.43641854021;5960.97019514904;5964.075568286922;5232.607554433394;5310.459966609678;5358.651687640291;5374.973125134349;5383.2732581101445;23644.408889777722;24062.67655278959;24280.90735916888;24403.511929761306;24657;2499.825012249143;2549.4901019796116;2659.215531418217;2821.5767634854733;2840.815347002459;14100.365483553162;14322.427102915872;14696.044757090755;15800.130992795392;15847.049177049414;1988.925979970814;2055.8149766521083;2084.2288353309373;2104.4738815296178;2125.90433430496;72167.27832721658;82585;83508.58245708793;84790;85992.57003714942;11531.942340288413;11564.884351156381;11757.823632645517;11851;11926.642200733992;16460.83539164617;16538.50384488467;16574.83425165733;16619.6676066478;16623.750643740354;8639.092895246034;8774.692885749097;8801.207891289814;8827.735167944971;8962.103789621116;8553.230209281195;8572.271356934605;8597.742067737978;8744.256738177199;8795.824083518293;5016.122178618727;5048.495150484996;5061.240813877874;5078.669886457368;5188.792448302026;2086.996483375946;2114.673858755357;2162.740471143473;2169.945751356229;2175.7715439878584;1006.9395836249848;1039.6257347354947;1062.845887346346;1088.2926098036182;1092.9125669946386;20025.799742002393;20083;20189.697154542693;20211.393658190278;20317.49206269855;1065.3288428290282;1091.3397394576168;1094.4199574225672;1096.4188979840696;1102.5865300512307;10819.188560857967;11205.775884482428;11281.71795705114;11305.547778088949;11307.604233851776;479355;482492;484975;515175;535874;93943;94637.05362946421;95018.5249073764;96364.51817740867;97899;1028.3315844701003;1050.6217761605815;1065.3128731967684;1066.7599790047332;1073.951672174754;17321.65356692834;17896.194671240086;18124.45626631203;18148.18333174984;18477.81522184761;43298.35052474152;43378;44155.77922110369;45197.54802451933;45293.77353113213;56985;59309.70345148247;60342.69828650829;60802.695986519786;61897.69051154715;8438.789030274293;8457.788555286166;8548.957255213933;8611.526366049928;8716.433431827165;9661.372010819274;12667.239965602093;13221.140625859289;14102.78845817293;14554.126752394466;11931.642050738492;11997.940010299893;12125.69685757863;12278.447469864057;12423.565175218824;11670.474828632901;11699.824502632297;12221.14451988388;12231;12442.813357799821;11611.709707257387;11797.35114568707;11968.880311196777;12425.068119890864;12466.376681166086;8496.150384961455;8670.82658346817;8700.434471759316;8772.649094036167;9031.232345250728;11322.433878305887;11589.362585057903;11918.702032449259;12229.93885030569;12593.93703031479 07:46:48 INFO - PROCESS | 15671 | |3;mootools.html;1519.4605914900214;1554.075325181517;1729.7837770278716;1848.8428483578887;1859.367814942919;8148.674053037871;8897.733068007954;8928.687495937644;9680.709578712642;9693.951530242348;9088.81822363554;9476.905230947688;9478.431294122358;9483.905160948389;9492.098250666175;2466.1121996081397;2479.367761220886;2492.1775813981435;2504.6368276599974;2509.7490250974847;2406.6750988616486;2476.5913624252066;2479.417336925821;2490.86300253486;2499.4376265340334;2404.711434627847;2414.239514552919;2440.4021014851387;2454.717707463638;2470.8393954392996;2415.975840241593;2428.5264373447185;2432.4405386761146;2435.3546310227803;2438.439158993424;2359.823013273994;2361.1853910400882;2366.3610825077135;2368.933979709138;2369.336585755991;9152.588133534007;9282.814343713155;9359.29805264601;9360.672376466791;9372.1565059145;5595.244641973363;5719.342275638313;5758.3665796762325;5758.74085666146;5760.222369980041;3575.0526110580718;3659.87190448333;3700.259948010382;3719.293334266508;3764.3976963685955;1156.8900954409319;1227.245244174835;1257.9496820127183;1259.1500737002486;1293.6701141209026;12937.676558086123;12956.80564791529;12964.80552791709;12991.870081299161;13062.150960187557;4867.221244600847;4869;4908.705477671279;4971.726555039508;5070.036693028313;10988.835167472495;11101.888981110085;11144.442777861075;11158.665240042812;11159.776804463865;5619.915701264485;5670.7731690732735;5672.319321681424;5673.3475650299915;5693.032184528557;4649.790759415834;5109;5212.947870521322;5239.816606418757;5244.895102097937;4261.722988005832;4346.5653434656915;4353.6299414549485;4372.3878656988045;4384.693071484965;1364.6793003644136;1368.6167872995577;1368.9726205475836;1370.3422357268369;1390.4646711016333;948.2129832239225;992.4045572656348;996.5465713100522;1040.3185913226848;1046.0899017854515;6215.564910456315;6300.936990630035;6325.652089135142;6367.076773867856;6480.513961452815;1106.2090605217147;1120.6077872744638;1135.6082151657665;1148.833419154218;1151.4645689754304;4156.314208155621;4220.451341325669;4269.146170765859;4287.592678695519;4415.66882483815;11378.487968041458;11535.192536522363;11706.531738730526;11752.76494470123;11801.822972655245;11536.134789890624;11616.361100139404;11627.883721162849;11628.6511404658;11664.533418663328;8463.915360846437;8524.147585241426;8534.70128545498;8624.223819856117;8769.298456123495;6110.480609148272;6110.7250173741395;6169.691515424301;6279.497640188865;6281.528885333527;10247.641332553325;10309.793804124025;10329.431881246604;10333.948330258301;10390.597269368538;10531.684049478528;10657.57369705203;10690.57237710514;10718.820929697571;10745.086667633339;7387.556746595222;7706.961465192639;7863.764087077397;8448.535330556879;8537.146285371413;9330.626774929198;9390.812183756423;9405.388649737744;9409.905900940903;9458.763530911783;8202.83594328122;8363.749087527383;8372.204640559137;8416.789580260542;8650.43772154808;8261.463004904663;8271.048829384697;8310.044344900414;8325.83348333042;8355.373346998878;7444.925550744423;7467.43994200448;7513.812154696177;7556;7631.122420921665;5280.815171469134;5322.9467705324;5398.78404863801;5417.43116972728;5451.591130665295;5446.128619420873;5532.6680399176175;5602.907433050516;5610.943890561042;5671.064274394678 07:46:48 INFO - PROCESS | 15671 | |4;prototype.html;317.7918463406468;329.3166679140783;330.809784373985;334.0679504183329;334.4097667616657;5833;5903.645781253128;5913.2017177681055;5938.1686563880985;5942.6137301075505;5808.448197421239;5830.591858569902;5840.240768700063;5853.09277062055;5892.88214235715;4285.849995250159;4389.429374181352;4419.580139886705;4478.708883922551;4485.573870482299;4478.387780399054;4481.0813783174535;4488.730676159425;4491.348754430605;4522.570355816192;4485.170243504946;4492.68551201416;4502.752348620825;4535.909281814362;4538.818447262105;4349.1301739652035;4471.441069866267;4473.405424853577;4481.5294394088805;4492.595666390041;3922.293987082324;3929.390944403622;3938.8030598469963;3942.704297177723;3947.940780888289;5602.60781745278;5659.094544872801;5673.375928647845;5707.971460142673;5712.6286791358425;5067.518585734386;5170.224466330043;5195.5324020837925;5216.739163041832;5220.947790522122;6097.323236110105;6112.419320164578;6120.5103591713005;6139.785107521216;6141.263048434216;4196.223698615766;4338.848140315074;4357.3899654048455;4389.341598760179;4410.691251612388;6223.564350495467;6310.116583678288;6325.335839736854;6337.809865704036;6342.0656699706105;4425.114977004612;4425.269830477935;4428.114377124588;4430.158269928703;4436.179306828247;4155.3143731284;4512.210363186429;4514.34541991416;4515.5484451554585;4517.12539296195;5074.67014644047;5078.542931136216;5096.847094587169;5103.438621751604;5149.407818100966;6077.36187700294;6146.784862529879;6195.349488303754;6206.224221972254;6231.2522497300615;1496.4014394242172;1515.4998850379347;1515.6589767302269;1516.7497362935212;1537.692461507703;926.9026752191057;948.3219498058921;960.078324808192;987.2546227598117;996.9551370188359;5896;5903.793367232126;5950.155451809953;5954.821355359346;5989.431004054608;6203.875922481616;6297.4017468340435;6327.177466929362;6338.176037115146;6381.329960354096;5704.971475142681;5880.558958078162;5892.436789996365;5911.290645122613;5914.290285165722;3332.483465062919;3335.4496508075895;3360.571757003264;3376;3405.506201600754;6224.688765561795;6415.390537898892;6452.612843229421;6537.248216455074;6596.472282217411;6453.386928241809;6480.384363485461;6493;6526.042187343778;6567.802965911031;6391.840203994937;6552.836179095465;6622.536422450478;6653.833654158685;6679.398854103154;6354.26925903527;6407.807765766848;6418.165638467156;6433.29233784274;6476.773312934025;6136.477896633506;6320.9772872680305;6322.209723784527;6339.590955437089;6391.009393544008;6502.284748677736;6555.115059466911;6564.80305590833;6567.146270984741;6592.934070659232;4361.49842768073;4391.385206071089;4396.4064851244675;4399.428074350314;4408.845690400821;6244.875102498016;6370.8088757337355;6407.1350367701625;6421.775237866652;6476.352364763486;6225.8132256032395;6230.252369715663;6251.843703907439;6253.3121356651645;6272.4982001440685;5889.882202356014;6191.690415479298;6213.96893015532;6235.282942461675;6250.281217660027;6018.969905150621;6104.481119104926;6180.47465965398;6192.133101365723;6196.566240363131;6254.186955695731;6293.811185664437;6303.590266632654;6312.747490100528;6329.810105696836;5930.970345148246;6096.969515152396;6104.847378815388;6107.8778424430375;6214.533909956681 07:46:48 INFO - PROCESS | 15671 | |5;yui.html;819.2422009641081;839.6557411461301;911.8541033434652;928.4568527411463;961.6105477281701;17089.40187093452;18015.639687206247;18067.186976586054;18132.728009079874;18205.635887282246;16311.755323670124;16674.33302667892;16788.58028549287;16790.160491975414;16873.071981041037;870.9346798990069;900.5767289373983;907.6777743900919;908.1100521488945;908.5775114571722;863.7797361672765;883.8541640629288;888.0320450708726;889.5818965086399;895.4358753984981;947.0340252941995;949.4303417949244;949.7483166960761;953.9284553658468;954.3224310739349;950.2920324358363;950.771814764455;950.9857352139724;951.148721893908;951.3911096897956;697.9651017449158;698.183125742882;698.4586945117524;700.527144177678;701.0115736811072;16201.59496012609;16335.754963675554;16348.673026539522;16366.590835229095;16382.426615068534;14097.36561854719;14655;14663.486777962828;15358.692826143526;16028.919855400765;14823.703525929528;14996.325165367476;15064.020838645563;15084.547463576111;15305.1582162981;4923.359963204761;4952.702837829742;5051.747412629391;5125.487451254882;5167.199084141964;84226.15773842245;87120.56439717824;87819.12180878174;88122.55938720329;88984.55507722485;12470.75058498825;12539.373031348396;12582.24506529611;12632.873671263169;12780.105392622612;21930.561388772454;21985.890070549543;22071;22071.33785986423;22144.66782998256;9168.862467063;9175.541222938826;9284.442933424016;9303.906960930439;9412;5143.794248230029;5180.481951804864;5202.531772140525;5341.092014357569;5344.251804747339;3630.8366123524506;3710.3135919854913;3736.308782875177;3738.158914244273;3742.251549690073;628.3904612525934;637.5027478566725;641.1248645598724;646.0309535696455;647.8639485708054;702.364360253971;754.0913199594476;763.8701420758484;773.1032002876636;807.2452257139594;10433.478326083665;10742.462876856125;11341.489632966537;11621.186516943902;11630.825537616942;732.1031736123207;823.7322870067132;857.2789331639973;858.6651206029653;867.700643278068;5387.461253874581;5402.837914862482;5426.945730542723;5439.456054394608;5593.440655934455;78261;78388.60805695935;136792.31603841917;137817;139074.3046284762;119243.40378298226;119902.400487997;121608;123857;125148.37425812813;87530.56234718658;88605.55697221601;94557;94653;105929.47035264774;9693.27300452483;10160.745981350525;10815.72960675958;11120.11039116885;11261.042811361127;44742.77628611836;52933.47066529439;53751;54458;54583.18125228204;81012.18987810047;82608.58695706724;83082.16917830745;84473;84576.57711711402;13496.147812097028;13569.796453053015;14035.368408421442;14037.1577705338;14082.929585352007;15764.921175394049;15960.199203385933;16058.669418863243;16246.837531624533;16543.172841358126;13945.930270348583;15438.5368438947;15707.607309817346;16781.412650557173;16783.496495105166;15072;15294.923525382303;15595.766063508829;15849.841501584837;16004.91997540005;14502.85497145015;14655.92672036633;15157.545273641808;15331.463398780988;15359.69280614359;12209.633710988684;12257.570985015482;12829.23024618526;12841.357932103545;13049;12832.679183020125;13090.869091308965;13140.802887956497;13414.396352163982;13546.525871594447 07:46:48 INFO - PROCESS | 15671 | __end_tp_report 07:46:48 INFO - PROCESS | 15671 | __start_cc_report 07:46:48 INFO - PROCESS | 15671 | _x_x_mozilla_cycle_collect,339 07:46:48 INFO - PROCESS | 15671 | __end_cc_report 07:46:48 INFO - PROCESS | 15671 | __startTimestamp1474123608354__endTimestamp 07:46:48 INFO - PROCESS | 15671 | 07:46:48 INFO - PROCESS | 15671 | ------- Summary: start ------- 07:46:48 INFO - PROCESS | 15671 | Number of tests: 6 07:46:48 INFO - PROCESS | 15671 | 07:46:48 INFO - PROCESS | 15671 | [#0] dojo.html Cycles:165 Average:5797.49 Median:6016.37 stddev:684.91 (11.4%) stddev-sans-first:657.30 07:46:48 INFO - PROCESS | 15671 | Values: 3253.6 3261.5 3274.1 3286.6 3318.8 5742.6 5758.7 5782.2 5847.3 5863.2 5823.4 5826.0 5925.3 5933.1 5938.8 5336.8 5388.2 5436.7 5457.6 5467.6 5178.5 5226.8 5268.0 5330.4 5366.8 5329.0 5373.4 5402.2 5429.2 5476.8 5441.8 5444.1 5445.8 5447.5 5450.6 5225.8 5233.7 5283.6 5371.7 5466.2 5759.9 5786.4 5803.1 5836.2 5852.6 6273.5 6322.4 6331.5 6343.3 6350.0 6121.4 6223.4 6345.6 6362.8 6385.4 5851.0 5907.1 5946.9 5947.3 5987.6 6447.2 6457.1 6510.3 6518.2 6523.0 5997.7 6073.7 6229.0 6241.1 6248.4 6146.3 6231.1 6275.8 6286.1 6295.2 6196.6 6215.3 6221.2 6233.3 6257.8 6015.7 6104.5 6214.8 6259.9 6270.1 4658.3 4715.3 4722.8 4736.2 4749.4 4189.4 4194.3 4194.5 4211.4 4221.1 5813.6 5850.2 5930.7 5959.5 5975.6 6133.4 6176.9 6187.6 6197.7 6214.6 5923.3 5929.3 5939.6 5943.8 5944.3 4982.6 4986.6 4995.3 5003.5 5034.2 6470.7 6507.6 6542.9 6548.5 6572.9 6199.3 6270.5 6319.6 6326.9 6335.7 6269.6 6298.4 6357.4 6538.2 6562.0 6098.4 6105.9 6114.3 6121.4 6126.5 6191.6 6232.5 6235.4 6257.5 6264.8 5924.8 6026.7 6036.9 6079.7 6092.7 6087.6 6095.3 6107.5 6128.1 6136.1 6058.0 6095.2 6102.1 6111.5 6125.5 6016.4 6053.0 6087.3 6116.3 6155.4 5988.5 6002.4 6011.9 6012.5 6030.7 07:46:48 INFO - PROCESS | 15671 | 07:46:48 INFO - PROCESS | 15671 | [#1] ext.html Cycles:180 Average:72569.75 Median:46679.03 stddev:150260.76 (321.9%) stddev-sans-first:150585.08 07:46:48 INFO - PROCESS | 15671 | Values: 582.9 625.6 633.4 653.6 674.8 41470.0 46248.8 46607.3 46628.1 46698.1 46265.8 46660.0 46701.5 46705.8 46987.0 9190.0 9258.6 9281.9 9293.3 9318.0 9072.7 9110.5 9139.9 9220.3 9230.5 9236.4 9353.3 9369.9 9382.8 9401.3 9226.8 9275.8 9287.7 9291.1 9307.3 9232.2 9253.8 9269.5 9338.5 9366.4 44869.6 44930.3 45010.3 45169.8 45245.3 3976.9 4013.6 4158.3 4329.0 4523.9 35415.6 35620.3 35793.1 36829.4 37471.8 4663.8 4684.0 4715.2 4809.2 4917.3 553229.0 561724.0 562267.0 562971.0 564522.0 66783.0 67778.7 67948.0 68286.7 68416.0 39988.2 72835.0 73016.3 73372.3 73381.3 17875.1 18405.4 18461.4 18559.6 18571.4 14326.6 14499.4 14546.0 14603.0 14619.1 20983.2 21334.4 21457.7 21464.8 21592.4 7573.8 7623.7 7767.4 7835.3 7948.8 1051.2 1052.3 1140.6 1183.8 1212.9 35161.6 35216.3 35360.8 35846.6 36098.3 1152.5 1266.8 1270.7 1270.8 1321.4 18437.8 18918.2 18961.8 19329.8 20719.8 661193.0 663348.0 666265.0 667350.0 669450.0 65033.0 65851.7 66027.3 66088.3 66198.7 1469.3 1484.6 1507.5 1516.1 1517.7 36218.6 36698.6 36839.8 37461.4 37637.9 59043.1 59657.0 59791.2 59954.4 60015.0 415802.0 417867.0 418268.0 418299.0 541114.0 31640.5 31957.5 32109.5 32507.2 32842.3 53212.2 53643.0 53745.4 53939.0 54387.7 37964.4 38462.0 45260.8 47992.0 48167.0 46988.1 47081.5 47139.8 47341.5 47668.8 45982.8 46790.9 47048.5 47439.8 47675.3 37968.6 41519.0 41921.6 42428.0 42965.4 31045.4 31642.0 31691.0 31805.8 32074.5 07:46:48 INFO - PROCESS | 15671 | 07:46:48 INFO - PROCESS | 15671 | [#2] jquery.html Cycles:180 Average:29970.43 Median:24171.79 stddev:82438.50 (341.1%) stddev-sans-first:82639.92 07:46:48 INFO - PROCESS | 15671 | Values: 425.6 429.6 433.8 435.8 441.4 19299.2 20437.1 20979.4 21057.6 21103.9 19391.6 19669.0 20094.0 20354.0 20382.0 5802.7 6053.6 6056.9 6070.5 6073.6 5885.2 5896.3 5913.7 5964.8 5969.3 5900.7 5916.1 5918.9 5930.8 5938.1 5883.9 5908.0 5932.4 5961.0 5964.1 5232.6 5310.5 5358.7 5375.0 5383.3 23644.4 24062.7 24280.9 24403.5 24657.0 2499.8 2549.5 2659.2 2821.6 2840.8 14100.4 14322.4 14696.0 15800.1 15847.0 1988.9 2055.8 2084.2 2104.5 2125.9 72167.3 82585.0 83508.6 84790.0 85992.6 11531.9 11564.9 11757.8 11851.0 11926.6 16460.8 16538.5 16574.8 16619.7 16623.8 8639.1 8774.7 8801.2 8827.7 8962.1 8553.2 8572.3 8597.7 8744.3 8795.8 5016.1 5048.5 5061.2 5078.7 5188.8 2087.0 2114.7 2162.7 2169.9 2175.8 1006.9 1039.6 1062.8 1088.3 1092.9 20025.8 20083.0 20189.7 20211.4 20317.5 1065.3 1091.3 1094.4 1096.4 1102.6 10819.2 11205.8 11281.7 11305.5 11307.6 479355.0 482492.0 484975.0 515175.0 535874.0 93943.0 94637.1 95018.5 96364.5 97899.0 1028.3 1050.6 1065.3 1066.8 1074.0 17321.7 17896.2 18124.5 18148.2 18477.8 43298.4 43378.0 44155.8 45197.5 45293.8 56985.0 59309.7 60342.7 60802.7 61897.7 8438.8 8457.8 8549.0 8611.5 8716.4 9661.4 12667.2 13221.1 14102.8 14554.1 11931.6 11997.9 12125.7 12278.4 12423.6 11670.5 11699.8 12221.1 12231.0 12442.8 11611.7 11797.4 11968.9 12425.1 12466.4 8496.2 8670.8 8700.4 8772.6 9031.2 11322.4 11589.4 11918.7 12229.9 12593.9 07:46:48 INFO - PROCESS | 15671 | 07:46:48 INFO - PROCESS | 15671 | [#3] mootools.html Cycles:180 Average:6170.65 Median:4400.18 stddev:3483.63 (79.2%) stddev-sans-first:3475.86 07:46:48 INFO - PROCESS | 15671 | Values: 1519.5 1554.1 1729.8 1848.8 1859.4 8148.7 8897.7 8928.7 9680.7 9694.0 9088.8 9476.9 9478.4 9483.9 9492.1 2466.1 2479.4 2492.2 2504.6 2509.7 2406.7 2476.6 2479.4 2490.9 2499.4 2404.7 2414.2 2440.4 2454.7 2470.8 2416.0 2428.5 2432.4 2435.4 2438.4 2359.8 2361.2 2366.4 2368.9 2369.3 9152.6 9282.8 9359.3 9360.7 9372.2 5595.2 5719.3 5758.4 5758.7 5760.2 3575.1 3659.9 3700.3 3719.3 3764.4 1156.9 1227.2 1257.9 1259.2 1293.7 12937.7 12956.8 12964.8 12991.9 13062.2 4867.2 4869.0 4908.7 4971.7 5070.0 10988.8 11101.9 11144.4 11158.7 11159.8 5619.9 5670.8 5672.3 5673.3 5693.0 4649.8 5109.0 5212.9 5239.8 5244.9 4261.7 4346.6 4353.6 4372.4 4384.7 1364.7 1368.6 1369.0 1370.3 1390.5 948.2 992.4 996.5 1040.3 1046.1 6215.6 6300.9 6325.7 6367.1 6480.5 1106.2 1120.6 1135.6 1148.8 1151.5 4156.3 4220.5 4269.1 4287.6 4415.7 11378.5 11535.2 11706.5 11752.8 11801.8 11536.1 11616.4 11627.9 11628.7 11664.5 8463.9 8524.1 8534.7 8624.2 8769.3 6110.5 6110.7 6169.7 6279.5 6281.5 10247.6 10309.8 10329.4 10333.9 10390.6 10531.7 10657.6 10690.6 10718.8 10745.1 7387.6 7707.0 7863.8 8448.5 8537.1 9330.6 9390.8 9405.4 9409.9 9458.8 8202.8 8363.7 8372.2 8416.8 8650.4 8261.5 8271.0 8310.0 8325.8 8355.4 7444.9 7467.4 7513.8 7556.0 7631.1 5280.8 5322.9 5398.8 5417.4 5451.6 5446.1 5532.7 5602.9 5610.9 5671.1 07:46:48 INFO - PROCESS | 15671 | 07:46:48 INFO - PROCESS | 15671 | [#4] prototype.html Cycles:180 Average:5169.66 Median:5922.63 stddev:1562.52 (26.4%) stddev-sans-first:1523.88 07:46:48 INFO - PROCESS | 15671 | Values: 317.8 329.3 330.8 334.1 334.4 5833.0 5903.6 5913.2 5938.2 5942.6 5808.4 5830.6 5840.2 5853.1 5892.9 4285.8 4389.4 4419.6 4478.7 4485.6 4478.4 4481.1 4488.7 4491.3 4522.6 4485.2 4492.7 4502.8 4535.9 4538.8 4349.1 4471.4 4473.4 4481.5 4492.6 3922.3 3929.4 3938.8 3942.7 3947.9 5602.6 5659.1 5673.4 5708.0 5712.6 5067.5 5170.2 5195.5 5216.7 5220.9 6097.3 6112.4 6120.5 6139.8 6141.3 4196.2 4338.8 4357.4 4389.3 4410.7 6223.6 6310.1 6325.3 6337.8 6342.1 4425.1 4425.3 4428.1 4430.2 4436.2 4155.3 4512.2 4514.3 4515.5 4517.1 5074.7 5078.5 5096.8 5103.4 5149.4 6077.4 6146.8 6195.3 6206.2 6231.3 1496.4 1515.5 1515.7 1516.7 1537.7 926.9 948.3 960.1 987.3 997.0 5896.0 5903.8 5950.2 5954.8 5989.4 6203.9 6297.4 6327.2 6338.2 6381.3 5705.0 5880.6 5892.4 5911.3 5914.3 3332.5 3335.4 3360.6 3376.0 3405.5 6224.7 6415.4 6452.6 6537.2 6596.5 6453.4 6480.4 6493.0 6526.0 6567.8 6391.8 6552.8 6622.5 6653.8 6679.4 6354.3 6407.8 6418.2 6433.3 6476.8 6136.5 6321.0 6322.2 6339.6 6391.0 6502.3 6555.1 6564.8 6567.1 6592.9 4361.5 4391.4 4396.4 4399.4 4408.8 6244.9 6370.8 6407.1 6421.8 6476.4 6225.8 6230.3 6251.8 6253.3 6272.5 5889.9 6191.7 6214.0 6235.3 6250.3 6019.0 6104.5 6180.5 6192.1 6196.6 6254.2 6293.8 6303.6 6312.7 6329.8 5931.0 6097.0 6104.8 6107.9 6214.5 07:46:48 INFO - PROCESS | 15671 | 07:46:48 INFO - PROCESS | 15671 | [#5] yui.html Cycles:180 Average:23011.94 Median:3737.23 stddev:33322.72 (891.6%) stddev-sans-first:33374.53 07:46:48 INFO - PROCESS | 15671 | Values: 819.2 839.7 911.9 928.5 961.6 17089.4 18015.6 18067.2 18132.7 18205.6 16311.8 16674.3 16788.6 16790.2 16873.1 870.9 900.6 907.7 908.1 908.6 863.8 883.9 888.0 889.6 895.4 947.0 949.4 949.7 953.9 954.3 950.3 950.8 951.0 951.1 951.4 698.0 698.2 698.5 700.5 701.0 16201.6 16335.8 16348.7 16366.6 16382.4 14097.4 14655.0 14663.5 15358.7 16028.9 14823.7 14996.3 15064.0 15084.5 15305.2 4923.4 4952.7 5051.7 5125.5 5167.2 84226.2 87120.6 87819.1 88122.6 88984.6 12470.8 12539.4 12582.2 12632.9 12780.1 21930.6 21985.9 22071.0 22071.3 22144.7 9168.9 9175.5 9284.4 9303.9 9412.0 5143.8 5180.5 5202.5 5341.1 5344.3 3630.8 3710.3 3736.3 3738.2 3742.3 628.4 637.5 641.1 646.0 647.9 702.4 754.1 763.9 773.1 807.2 10433.5 10742.5 11341.5 11621.2 11630.8 732.1 823.7 857.3 858.7 867.7 5387.5 5402.8 5426.9 5439.5 5593.4 78261.0 78388.6 136792.3 137817.0 139074.3 119243.4 119902.4 121608.0 123857.0 125148.4 87530.6 88605.6 94557.0 94653.0 105929.5 9693.3 10160.7 10815.7 11120.1 11261.0 44742.8 52933.5 53751.0 54458.0 54583.2 81012.2 82608.6 83082.2 84473.0 84576.6 13496.1 13569.8 14035.4 14037.2 14082.9 15764.9 15960.2 16058.7 16246.8 16543.2 13945.9 15438.5 15707.6 16781.4 16783.5 15072.0 15294.9 15595.8 15849.8 16004.9 14502.9 14655.9 15157.5 15331.5 15359.7 12209.6 12257.6 12829.2 12841.4 13049.0 12832.7 13090.9 13140.8 13414.4 13546.5 07:46:48 INFO - PROCESS | 15671 | -------- Summary: end -------- 07:46:48 INFO - PROCESS | 15671 | 07:46:49 INFO - TEST-INFO | 15671: exit 0 07:46:49 INFO - TEST-OK | dromaeo_css | took 1111447ms 07:46:49 INFO - TEST-START | kraken 07:46:49 INFO - operating with platform_type : linux_ 07:46:49 INFO - Initialising browser for kraken test... 07:46:49 INFO - TEST-INFO | started process 15967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ2cxmi/profile http://localhost:32808/getInfo.html) 07:46:53 INFO - PROCESS | 15967 | __metrics Screen width/height:1600/1200 07:46:53 INFO - PROCESS | 15967 | colorDepth:24 07:46:53 INFO - PROCESS | 15967 | Browser inner width/height: 1024/697 07:46:53 INFO - PROCESS | 15967 | __metrics 07:46:54 ERROR - PROCESS | 15967 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:46:55 INFO - TEST-INFO | 15967: exit 0 07:46:55 INFO - Browser initialized. 07:46:55 INFO - Running cycle 1/1 for kraken test... 07:46:55 INFO - TEST-INFO | started process 16094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ2cxmi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:06 INFO - PROCESS | 16094 | RSS: Main: 153333760 07:47:06 INFO - PROCESS | 16094 | 07:47:09 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32808/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:10 INFO - PROCESS | 16094 | RSS: Main: 158588928 07:47:10 INFO - PROCESS | 16094 | 07:47:12 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32808/tests/kraken/driver.html?testName=audio-dft) 07:47:13 INFO - PROCESS | 16094 | RSS: Main: 157097984 07:47:13 INFO - PROCESS | 16094 | 07:47:16 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32808/tests/kraken/driver.html?testName=audio-fft) 07:47:16 INFO - PROCESS | 16094 | RSS: Main: 157782016 07:47:16 INFO - PROCESS | 16094 | 07:47:19 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32808/tests/kraken/driver.html?testName=audio-oscillator) 07:47:19 INFO - PROCESS | 16094 | RSS: Main: 157880320 07:47:19 INFO - PROCESS | 16094 | 07:47:21 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32808/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:47:22 INFO - PROCESS | 16094 | RSS: Main: 158535680 07:47:22 INFO - PROCESS | 16094 | 07:47:25 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32808/tests/kraken/driver.html?testName=imaging-darkroom) 07:47:26 INFO - PROCESS | 16094 | RSS: Main: 158064640 07:47:26 INFO - PROCESS | 16094 | 07:47:29 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32808/tests/kraken/driver.html?testName=imaging-desaturate) 07:47:30 INFO - PROCESS | 16094 | RSS: Main: 156073984 07:47:30 INFO - PROCESS | 16094 | 07:47:33 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32808/tests/kraken/driver.html?testName=json-parse-financial) 07:47:33 INFO - PROCESS | 16094 | RSS: Main: 157462528 07:47:33 INFO - PROCESS | 16094 | 07:47:35 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32808/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:47:35 INFO - PROCESS | 16094 | RSS: Main: 156905472 07:47:35 INFO - PROCESS | 16094 | 07:47:37 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32808/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:38 INFO - PROCESS | 16094 | RSS: Main: 156717056 07:47:38 INFO - PROCESS | 16094 | 07:47:40 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32808/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:47:41 INFO - PROCESS | 16094 | RSS: Main: 157138944 07:47:41 INFO - PROCESS | 16094 | 07:47:43 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:47:44 INFO - PROCESS | 16094 | RSS: Main: 157470720 07:47:44 INFO - PROCESS | 16094 | 07:47:46 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:47:47 INFO - PROCESS | 16094 | RSS: Main: 158076928 07:47:47 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | Cycle 1(1): loaded http://localhost:32808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32808/tests/kraken/driver.html?testName=ai-astar) 07:47:49 INFO - PROCESS | 16094 | RSS: Main: 160219136 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | __start_tp_report 07:47:49 INFO - PROCESS | 16094 | _x_x_mozilla_page_load 07:47:49 INFO - PROCESS | 16094 | _x_x_mozilla_page_load_details 07:47:49 INFO - PROCESS | 16094 | |i|pagename|runs| 07:47:49 INFO - PROCESS | 16094 | |0;ai-astar;110;111;102;110;110;110;97;111;110;111 07:47:49 INFO - PROCESS | 16094 | |1;audio-beat-detection;146;116;142;183;116;152;144;122;168;119 07:47:49 INFO - PROCESS | 16094 | |2;audio-dft;162;164;163;163;163;162;162;162;161;161 07:47:49 INFO - PROCESS | 16094 | |3;audio-fft;75;74;75;182;77;75;79;84;182;79 07:47:49 INFO - PROCESS | 16094 | |4;audio-oscillator;85;83;143;83;83;85;142;84;84;148 07:47:49 INFO - PROCESS | 16094 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;121;124;120 07:47:49 INFO - PROCESS | 16094 | |6;imaging-darkroom;147;148;147;147;147;147;148;148;147;147 07:47:49 INFO - PROCESS | 16094 | |7;imaging-desaturate;96;95;95;95;95;95;95;96;96;95 07:47:49 INFO - PROCESS | 16094 | |8;json-parse-financial;51;52;53;51;52;51;51;55;51;50 07:47:49 INFO - PROCESS | 16094 | |9;json-stringify-tinderbox;61;60;61;62;64;60;61;61;61;60 07:47:49 INFO - PROCESS | 16094 | |10;stanford-crypto-aes;73;73;74;82;75;77;74;72;81;77 07:47:49 INFO - PROCESS | 16094 | |11;stanford-crypto-ccm;120;121;128;120;118;126;117;121;153;121 07:47:49 INFO - PROCESS | 16094 | |12;stanford-crypto-pbkdf2;156;165;162;152;155;155;158;155;150;152 07:47:49 INFO - PROCESS | 16094 | |13;stanford-crypto-sha256-iterative;62;63;62;61;63;61;61;61;61;60 07:47:49 INFO - PROCESS | 16094 | __end_tp_report 07:47:49 INFO - PROCESS | 16094 | __start_cc_report 07:47:49 INFO - PROCESS | 16094 | _x_x_mozilla_cycle_collect,878 07:47:49 INFO - PROCESS | 16094 | __end_cc_report 07:47:49 INFO - PROCESS | 16094 | __startTimestamp1474123669342__endTimestamp 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | ------- Summary: start ------- 07:47:49 INFO - PROCESS | 16094 | Number of tests: 14 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.50 stddev:4.76 (4.3%) stddev-sans-first:5.00 07:47:49 INFO - PROCESS | 16094 | Values: 110.0 111.0 102.0 110.0 110.0 110.0 97.0 111.0 110.0 111.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:145.00 stddev:22.96 (15.8%) stddev-sans-first:24.27 07:47:49 INFO - PROCESS | 16094 | Values: 146.0 116.0 142.0 183.0 116.0 152.0 144.0 122.0 168.0 119.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 07:47:49 INFO - PROCESS | 16094 | Values: 162.0 164.0 163.0 163.0 163.0 162.0 162.0 162.0 161.0 161.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#3] audio-fft Cycles:10 Average:98.20 Median:76.00 stddev:44.26 (58.2%) stddev-sans-first:46.15 07:47:49 INFO - PROCESS | 16094 | Values: 75.0 74.0 75.0 182.0 77.0 75.0 79.0 84.0 182.0 79.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:83.50 stddev:29.26 (35.0%) stddev-sans-first:30.38 07:47:49 INFO - PROCESS | 16094 | Values: 85.0 83.0 143.0 83.0 83.0 85.0 142.0 84.0 84.0 148.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.00 stddev:2.37 (2.0%) stddev-sans-first:2.44 07:47:49 INFO - PROCESS | 16094 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 121.0 124.0 120.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:47:49 INFO - PROCESS | 16094 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:47:49 INFO - PROCESS | 16094 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:51.50 stddev:1.42 (2.8%) stddev-sans-first:1.48 07:47:49 INFO - PROCESS | 16094 | Values: 51.0 52.0 53.0 51.0 52.0 51.0 51.0 55.0 51.0 50.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:1.20 (2.0%) stddev-sans-first:1.27 07:47:49 INFO - PROCESS | 16094 | Values: 61.0 60.0 61.0 62.0 64.0 60.0 61.0 61.0 61.0 60.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:3.43 (4.5%) stddev-sans-first:3.48 07:47:49 INFO - PROCESS | 16094 | Values: 73.0 73.0 74.0 82.0 75.0 77.0 74.0 72.0 81.0 77.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:121.00 stddev:10.55 (8.7%) stddev-sans-first:11.07 07:47:49 INFO - PROCESS | 16094 | Values: 120.0 121.0 128.0 120.0 118.0 126.0 117.0 121.0 153.0 121.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:155.50 stddev:4.62 (3.0%) stddev-sans-first:4.90 07:47:49 INFO - PROCESS | 16094 | Values: 156.0 165.0 162.0 152.0 155.0 155.0 158.0 155.0 150.0 152.0 07:47:49 INFO - PROCESS | 16094 | 07:47:49 INFO - PROCESS | 16094 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:0.97 (1.6%) stddev-sans-first:1.01 07:47:49 INFO - PROCESS | 16094 | Values: 62.0 63.0 62.0 61.0 63.0 61.0 61.0 61.0 61.0 60.0 07:47:49 INFO - PROCESS | 16094 | -------- Summary: end -------- 07:47:49 INFO - PROCESS | 16094 | 07:47:50 INFO - TEST-INFO | 16094: exit 0 07:47:50 INFO - TEST-OK | kraken | took 61233ms 07:47:50 INFO - SUITE-END | took 1172s 07:47:50 INFO - Completed test suite (00:19:32) 07:47:50 INFO - javascript benchmark 07:47:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7911.428762724472, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3253.5607692961444, 3261.494468357404, 3274.083256688127, 3286.6220384655758, 3318.7842790218633, 5742.598018138732, 5758.7408566614495, 5782.248307719996, 5847.26909136358, 5863.208466856973, 5823.388544202861, 5826.0, 5925.31858836234, 5933.13969474427, 5938.7624495020145, 5336.839894803162, 5388.164834450647, 5436.700981446019, 5457.590680698943, 5467.644603100805, 5178.48215178481, 5226.7909283628605, 5268.025415298182, 5330.387005494379, 5366.838994830161, 5328.973355133219, 5373.382061062989, 5402.216678581603, 5429.158480435519, 5476.7535460904155, 5441.809536666197, 5444.101723215645, 5445.809396671137, 5447.45525447456, 5450.591205659572, 5225.843224703265, 5233.685978841282, 5283.577313814885, 5371.650842695212, 5466.180072989044, 5759.856003599902, 5786.392428794958, 5803.071508558653, 5836.182934389189, 5852.619579727304, 6273.466755325803, 6322.399372059647, 6331.525135614847, 6343.302236753953, 6349.952257877445, 6121.422488707842, 6223.3776622337855, 6345.619262844198, 6362.77730279438, 6385.425311721968, 5850.976079186125, 5907.054871220627, 5946.8810623787285, 5947.316058653267, 5987.6108052976415, 6447.226332839996, 6457.1282876811965, 6510.25132109804, 6518.152640156749, 6523.021546768023, 5997.730102145414, 6073.696315184311, 6229.034499652561, 6241.095041218998, 6248.375162483806, 6146.262448506208, 6231.065340199007, 6275.843103922347, 6286.119943207955, 6295.181626388632, 6196.628202307876, 6215.285242197205, 6221.222347206599, 6233.283172435137, 6257.812265632038, 6015.729292181863, 6104.4505994460715, 6214.751409943642, 6259.906101408483, 6270.090836828635, 4658.34783130362, 4715.269133284346, 4722.763861806896, 4736.194846876039, 4749.430068391815, 4189.392538081961, 4194.2869712149, 4194.517630472474, 4211.389348544444, 4221.092465120014, 5813.593048486566, 5850.180974663551, 5930.733117009745, 5959.463648271676, 5975.551833612496, 6133.3866613339205, 6176.907346389808, 6187.566870319124, 6197.659128747872, 6214.5960512566535, 5923.259592550931, 5929.318128415288, 5939.613925094855, 5943.821685349447, 5944.346121926585, 4982.576480999156, 4986.601071914238, 4995.275685025651, 5003.54968052877, 5034.16936205522, 6470.708818103197, 6507.577007494498, 6542.869142617121, 6548.541602087808, 6572.86854262912, 6199.3490683477585, 6270.529710271657, 6319.557630965972, 6326.936730632635, 6335.714892829926, 6269.623822570478, 6298.401651843067, 6357.364263573606, 6538.1500404947055, 6562.048502967138, 6098.420650038239, 6105.8836979267135, 6114.266288045463, 6121.418465245794, 6126.5098792097415, 6191.628502289877, 6232.54841647876, 6235.376462353728, 6257.4994000480765, 6264.812055638338, 5924.822255332347, 6026.668533230714, 6036.879262414815, 6079.696015199311, 6092.725827337869, 6087.634741915499, 6095.2685677718955, 6107.511399087974, 6128.142060111499, 6136.079588061648, 6057.969710151598, 6095.1771510845465, 6102.145699601971, 6111.5110791137495, 6125.509959203342, 6016.368281330398, 6052.969735151296, 6087.269527656709, 6116.29662588808, 6155.384461553809, 5988.520918326436, 6002.369751176064, 6011.87976240464, 6012.518998480024, 6030.698465076816], "value": 5748.7570654466745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.8571999860035, 625.6027422586658, 633.3508154142002, 653.5686446945017, 674.7503423733219, 41470.0, 46248.76875615617, 46607.30089048663, 46628.067438651204, 46698.06603867921, 46265.76867115668, 46660.0, 46701.53298467014, 46705.766471167684, 46987.0, 9190.0, 9258.583363748647, 9281.860772088425, 9293.303002274823, 9317.95341023294, 9072.682456114037, 9110.544472776368, 9139.908600914005, 9220.30847686423, 9230.492322922237, 9236.353455258135, 9353.298502612297, 9369.859452108223, 9382.765430864249, 9401.294902882277, 9226.815463690722, 9275.814483710355, 9287.674931377403, 9291.117343852356, 9307.255419566418, 9232.215261702764, 9253.814923701555, 9269.536523173882, 9338.533073346374, 9366.391184572982, 44869.551304486864, 44930.32604510935, 45010.32484512735, 45169.774151129364, 45245.32132018022, 3976.920461590781, 4013.6387725104883, 4158.272302347077, 4329.012901884288, 4523.932141017887, 35415.64584354149, 35620.28759424823, 35793.1051723709, 36829.44755828665, 37471.81264093662, 4663.764102512803, 4684.0, 4715.245560710304, 4809.206480930678, 4917.286993385939, 553229.0, 561724.0, 562267.0, 562971.0, 564522.0, 66783.0, 67778.66110669416, 67948.0, 68286.65856670684, 68416.0, 39988.200235995115, 72835.0, 73016.26983730201, 73372.26627733654, 73381.26618733851, 17875.106244687715, 18405.355812546764, 18461.446156615322, 18559.628807424047, 18571.44285671432, 14326.57020289393, 14499.420023198954, 14546.0, 14603.0, 14619.122852628876, 20983.16067357319, 21334.35996920095, 21457.67813482799, 21464.78535214659, 21592.35222943314, 7573.848523029508, 7623.733169339046, 7767.417443691746, 7835.255650713173, 7948.801279968047, 1051.2063392138887, 1052.2634156090767, 1140.6007897235902, 1183.7691650128143, 1212.9454174562165, 35161.648383515836, 35216.29567408689, 35360.82319588437, 35846.64153358433, 36098.27803443969, 1152.521703493041, 1266.7909794883742, 1270.720441502868, 1270.7585558743808, 1321.359140816703, 18437.815621843878, 18918.243270269035, 18961.810381896004, 19329.80670193308, 20719.792802072086, 661193.0, 663348.0, 666265.0, 667350.0, 669450.0, 65033.0, 65851.67074164598, 66027.33972660308, 66088.33911660821, 66198.66900665466, 1469.2727100085312, 1484.5917372722588, 1507.4648499782638, 1516.0600427734655, 1517.6661134550382, 36218.63781362153, 36698.633013669525, 36839.81580092083, 37461.4380784283, 37637.87086387413, 59043.114353283876, 59657.0, 59791.20626381216, 59954.40045599663, 60015.0, 415802.0, 417867.0, 418268.0, 418299.0, 541114.0, 31640.525392118678, 31957.520637190926, 32109.51835722419, 32507.187320316236, 32842.343153137284, 53212.20181697355, 53643.0, 53745.387638370914, 53939.0, 54387.72806135944, 37964.43053354147, 38462.0, 45260.77369613262, 47992.0, 48167.0, 46988.05405378416, 47081.529184709085, 47139.764301179646, 47341.526584733714, 47668.7616561915, 45982.77008614936, 46790.93994791136, 47048.529514705784, 47439.762801185774, 47675.28487072766, 37968.620313796506, 41519.0, 41921.58078419177, 42428.0, 42965.35551966786, 31045.379092418476, 31642.0, 31691.04926852198, 31805.840970794998, 32074.518882216318], "value": 22477.961890230297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.6063141594025, 429.6298461223716, 433.79828379803394, 435.80388825028734, 441.3798612948806, 19299.228030878767, 20437.080331385107, 20979.370618881458, 21057.57884842306, 21103.894480527593, 19391.612167756637, 19669.0, 20094.0, 20354.0, 20382.0, 5802.738876750545, 6053.576249662526, 6056.878862422749, 6070.514358851281, 6073.63558186508, 5885.234919460486, 5896.292444906596, 5913.704314784265, 5964.761409543613, 5969.283685957691, 5900.675462849542, 5916.083007133901, 5918.852028699295, 5930.822075337725, 5938.138969849391, 5883.8529036774, 5908.0, 5932.43641854021, 5960.97019514904, 5964.075568286922, 5232.607554433394, 5310.459966609678, 5358.651687640291, 5374.973125134349, 5383.2732581101445, 23644.408889777722, 24062.67655278959, 24280.90735916888, 24403.511929761306, 24657.0, 2499.825012249143, 2549.4901019796116, 2659.215531418217, 2821.5767634854733, 2840.815347002459, 14100.365483553162, 14322.427102915872, 14696.044757090755, 15800.130992795392, 15847.049177049414, 1988.925979970814, 2055.8149766521083, 2084.2288353309373, 2104.4738815296178, 2125.90433430496, 72167.27832721658, 82585.0, 83508.58245708793, 84790.0, 85992.57003714942, 11531.942340288413, 11564.884351156381, 11757.823632645517, 11851.0, 11926.642200733992, 16460.83539164617, 16538.50384488467, 16574.83425165733, 16619.6676066478, 16623.750643740354, 8639.092895246034, 8774.692885749097, 8801.207891289814, 8827.735167944971, 8962.103789621116, 8553.230209281195, 8572.271356934605, 8597.742067737978, 8744.256738177199, 8795.824083518293, 5016.122178618727, 5048.495150484996, 5061.240813877874, 5078.669886457368, 5188.792448302026, 2086.996483375946, 2114.673858755357, 2162.740471143473, 2169.945751356229, 2175.7715439878584, 1006.9395836249848, 1039.6257347354947, 1062.845887346346, 1088.2926098036182, 1092.9125669946386, 20025.799742002393, 20083.0, 20189.697154542693, 20211.393658190278, 20317.49206269855, 1065.3288428290282, 1091.3397394576168, 1094.4199574225672, 1096.4188979840696, 1102.5865300512307, 10819.188560857967, 11205.775884482428, 11281.71795705114, 11305.547778088949, 11307.604233851776, 479355.0, 482492.0, 484975.0, 515175.0, 535874.0, 93943.0, 94637.05362946421, 95018.5249073764, 96364.51817740867, 97899.0, 1028.3315844701003, 1050.6217761605815, 1065.3128731967684, 1066.7599790047332, 1073.951672174754, 17321.65356692834, 17896.194671240086, 18124.45626631203, 18148.18333174984, 18477.81522184761, 43298.35052474152, 43378.0, 44155.77922110369, 45197.54802451933, 45293.77353113213, 56985.0, 59309.70345148247, 60342.69828650829, 60802.695986519786, 61897.69051154715, 8438.789030274293, 8457.788555286166, 8548.957255213933, 8611.526366049928, 8716.433431827165, 9661.372010819274, 12667.239965602093, 13221.140625859289, 14102.78845817293, 14554.126752394466, 11931.642050738492, 11997.940010299893, 12125.69685757863, 12278.447469864057, 12423.565175218824, 11670.474828632901, 11699.824502632297, 12221.14451988388, 12231.0, 12442.813357799821, 11611.709707257387, 11797.35114568707, 11968.880311196777, 12425.068119890864, 12466.376681166086, 8496.150384961455, 8670.82658346817, 8700.434471759316, 8772.649094036167, 9031.232345250728, 11322.433878305887, 11589.362585057903, 11918.702032449259, 12229.93885030569, 12593.93703031479], "value": 9747.869501860909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.4605914900214, 1554.075325181517, 1729.7837770278716, 1848.8428483578887, 1859.367814942919, 8148.674053037871, 8897.733068007954, 8928.687495937644, 9680.709578712642, 9693.951530242348, 9088.81822363554, 9476.905230947688, 9478.431294122358, 9483.905160948389, 9492.098250666175, 2466.1121996081397, 2479.367761220886, 2492.1775813981435, 2504.6368276599974, 2509.7490250974847, 2406.6750988616486, 2476.5913624252066, 2479.417336925821, 2490.86300253486, 2499.4376265340334, 2404.711434627847, 2414.239514552919, 2440.4021014851387, 2454.717707463638, 2470.8393954392996, 2415.975840241593, 2428.5264373447185, 2432.4405386761146, 2435.3546310227803, 2438.439158993424, 2359.823013273994, 2361.1853910400882, 2366.3610825077135, 2368.933979709138, 2369.336585755991, 9152.588133534007, 9282.814343713155, 9359.29805264601, 9360.672376466791, 9372.1565059145, 5595.244641973363, 5719.342275638313, 5758.3665796762325, 5758.74085666146, 5760.222369980041, 3575.0526110580718, 3659.87190448333, 3700.259948010382, 3719.293334266508, 3764.3976963685955, 1156.8900954409319, 1227.245244174835, 1257.9496820127183, 1259.1500737002486, 1293.6701141209026, 12937.676558086123, 12956.80564791529, 12964.80552791709, 12991.870081299161, 13062.150960187557, 4867.221244600847, 4869.0, 4908.705477671279, 4971.726555039508, 5070.036693028313, 10988.835167472495, 11101.888981110085, 11144.442777861075, 11158.665240042812, 11159.776804463865, 5619.915701264485, 5670.7731690732735, 5672.319321681424, 5673.3475650299915, 5693.032184528557, 4649.790759415834, 5109.0, 5212.947870521322, 5239.816606418757, 5244.895102097937, 4261.722988005832, 4346.5653434656915, 4353.6299414549485, 4372.3878656988045, 4384.693071484965, 1364.6793003644136, 1368.6167872995577, 1368.9726205475836, 1370.3422357268369, 1390.4646711016333, 948.2129832239225, 992.4045572656348, 996.5465713100522, 1040.3185913226848, 1046.0899017854515, 6215.564910456315, 6300.936990630035, 6325.652089135142, 6367.076773867856, 6480.513961452815, 1106.2090605217147, 1120.6077872744638, 1135.6082151657665, 1148.833419154218, 1151.4645689754304, 4156.314208155621, 4220.451341325669, 4269.146170765859, 4287.592678695519, 4415.66882483815, 11378.487968041458, 11535.192536522363, 11706.531738730526, 11752.76494470123, 11801.822972655245, 11536.134789890624, 11616.361100139404, 11627.883721162849, 11628.6511404658, 11664.533418663328, 8463.915360846437, 8524.147585241426, 8534.70128545498, 8624.223819856117, 8769.298456123495, 6110.480609148272, 6110.7250173741395, 6169.691515424301, 6279.497640188865, 6281.528885333527, 10247.641332553325, 10309.793804124025, 10329.431881246604, 10333.948330258301, 10390.597269368538, 10531.684049478528, 10657.57369705203, 10690.57237710514, 10718.820929697571, 10745.086667633339, 7387.556746595222, 7706.961465192639, 7863.764087077397, 8448.535330556879, 8537.146285371413, 9330.626774929198, 9390.812183756423, 9405.388649737744, 9409.905900940903, 9458.763530911783, 8202.83594328122, 8363.749087527383, 8372.204640559137, 8416.789580260542, 8650.43772154808, 8261.463004904663, 8271.048829384697, 8310.044344900414, 8325.83348333042, 8355.373346998878, 7444.925550744423, 7467.43994200448, 7513.812154696177, 7556.0, 7631.122420921665, 5280.815171469134, 5322.9467705324, 5398.78404863801, 5417.43116972728, 5451.591130665295, 5446.128619420873, 5532.6680399176175, 5602.907433050516, 5610.943890561042, 5671.064274394678], "value": 4957.812072286143, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.7918463406468, 329.3166679140783, 330.809784373985, 334.0679504183329, 334.4097667616657, 5833.0, 5903.645781253128, 5913.2017177681055, 5938.1686563880985, 5942.6137301075505, 5808.448197421239, 5830.591858569902, 5840.240768700063, 5853.09277062055, 5892.88214235715, 4285.849995250159, 4389.429374181352, 4419.580139886705, 4478.708883922551, 4485.573870482299, 4478.387780399054, 4481.0813783174535, 4488.730676159425, 4491.348754430605, 4522.570355816192, 4485.170243504946, 4492.68551201416, 4502.752348620825, 4535.909281814362, 4538.818447262105, 4349.1301739652035, 4471.441069866267, 4473.405424853577, 4481.5294394088805, 4492.595666390041, 3922.293987082324, 3929.390944403622, 3938.8030598469963, 3942.704297177723, 3947.940780888289, 5602.60781745278, 5659.094544872801, 5673.375928647845, 5707.971460142673, 5712.6286791358425, 5067.518585734386, 5170.224466330043, 5195.5324020837925, 5216.739163041832, 5220.947790522122, 6097.323236110105, 6112.419320164578, 6120.5103591713005, 6139.785107521216, 6141.263048434216, 4196.223698615766, 4338.848140315074, 4357.3899654048455, 4389.341598760179, 4410.691251612388, 6223.564350495467, 6310.116583678288, 6325.335839736854, 6337.809865704036, 6342.0656699706105, 4425.114977004612, 4425.269830477935, 4428.114377124588, 4430.158269928703, 4436.179306828247, 4155.3143731284, 4512.210363186429, 4514.34541991416, 4515.5484451554585, 4517.12539296195, 5074.67014644047, 5078.542931136216, 5096.847094587169, 5103.438621751604, 5149.407818100966, 6077.36187700294, 6146.784862529879, 6195.349488303754, 6206.224221972254, 6231.2522497300615, 1496.4014394242172, 1515.4998850379347, 1515.6589767302269, 1516.7497362935212, 1537.692461507703, 926.9026752191057, 948.3219498058921, 960.078324808192, 987.2546227598117, 996.9551370188359, 5896.0, 5903.793367232126, 5950.155451809953, 5954.821355359346, 5989.431004054608, 6203.875922481616, 6297.4017468340435, 6327.177466929362, 6338.176037115146, 6381.329960354096, 5704.971475142681, 5880.558958078162, 5892.436789996365, 5911.290645122613, 5914.290285165722, 3332.483465062919, 3335.4496508075895, 3360.571757003264, 3376.0, 3405.506201600754, 6224.688765561795, 6415.390537898892, 6452.612843229421, 6537.248216455074, 6596.472282217411, 6453.386928241809, 6480.384363485461, 6493.0, 6526.042187343778, 6567.802965911031, 6391.840203994937, 6552.836179095465, 6622.536422450478, 6653.833654158685, 6679.398854103154, 6354.26925903527, 6407.807765766848, 6418.165638467156, 6433.29233784274, 6476.773312934025, 6136.477896633506, 6320.9772872680305, 6322.209723784527, 6339.590955437089, 6391.009393544008, 6502.284748677736, 6555.115059466911, 6564.80305590833, 6567.146270984741, 6592.934070659232, 4361.49842768073, 4391.385206071089, 4396.4064851244675, 4399.428074350314, 4408.845690400821, 6244.875102498016, 6370.8088757337355, 6407.1350367701625, 6421.775237866652, 6476.352364763486, 6225.8132256032395, 6230.252369715663, 6251.843703907439, 6253.3121356651645, 6272.4982001440685, 5889.882202356014, 6191.690415479298, 6213.96893015532, 6235.282942461675, 6250.281217660027, 6018.969905150621, 6104.481119104926, 6180.47465965398, 6192.133101365723, 6196.566240363131, 6254.186955695731, 6293.811185664437, 6303.590266632654, 6312.747490100528, 6329.810105696836, 5930.970345148246, 6096.969515152396, 6104.847378815388, 6107.8778424430375, 6214.533909956681], "value": 4652.829740154391, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.2422009641081, 839.6557411461301, 911.8541033434652, 928.4568527411463, 961.6105477281701, 17089.40187093452, 18015.639687206247, 18067.186976586054, 18132.728009079874, 18205.635887282246, 16311.755323670124, 16674.33302667892, 16788.58028549287, 16790.160491975414, 16873.071981041037, 870.9346798990069, 900.5767289373983, 907.6777743900919, 908.1100521488945, 908.5775114571722, 863.7797361672765, 883.8541640629288, 888.0320450708726, 889.5818965086399, 895.4358753984981, 947.0340252941995, 949.4303417949244, 949.7483166960761, 953.9284553658468, 954.3224310739349, 950.2920324358363, 950.771814764455, 950.9857352139724, 951.148721893908, 951.3911096897956, 697.9651017449158, 698.183125742882, 698.4586945117524, 700.527144177678, 701.0115736811072, 16201.59496012609, 16335.754963675554, 16348.673026539522, 16366.590835229095, 16382.426615068534, 14097.36561854719, 14655.0, 14663.486777962828, 15358.692826143526, 16028.919855400765, 14823.703525929528, 14996.325165367476, 15064.020838645563, 15084.547463576111, 15305.1582162981, 4923.359963204761, 4952.702837829742, 5051.747412629391, 5125.487451254882, 5167.199084141964, 84226.15773842245, 87120.56439717824, 87819.12180878174, 88122.55938720329, 88984.55507722485, 12470.75058498825, 12539.373031348396, 12582.24506529611, 12632.873671263169, 12780.105392622612, 21930.561388772454, 21985.890070549543, 22071.0, 22071.33785986423, 22144.66782998256, 9168.862467063, 9175.541222938826, 9284.442933424016, 9303.906960930439, 9412.0, 5143.794248230029, 5180.481951804864, 5202.531772140525, 5341.092014357569, 5344.251804747339, 3630.8366123524506, 3710.3135919854913, 3736.308782875177, 3738.158914244273, 3742.251549690073, 628.3904612525934, 637.5027478566725, 641.1248645598724, 646.0309535696455, 647.8639485708054, 702.364360253971, 754.0913199594476, 763.8701420758484, 773.1032002876636, 807.2452257139594, 10433.478326083665, 10742.462876856125, 11341.489632966537, 11621.186516943902, 11630.825537616942, 732.1031736123207, 823.7322870067132, 857.2789331639973, 858.6651206029653, 867.700643278068, 5387.461253874581, 5402.837914862482, 5426.945730542723, 5439.456054394608, 5593.440655934455, 78261.0, 78388.60805695935, 136792.31603841917, 137817.0, 139074.3046284762, 119243.40378298226, 119902.400487997, 121608.0, 123857.0, 125148.37425812813, 87530.56234718658, 88605.55697221601, 94557.0, 94653.0, 105929.47035264774, 9693.27300452483, 10160.745981350525, 10815.72960675958, 11120.11039116885, 11261.042811361127, 44742.77628611836, 52933.47066529439, 53751.0, 54458.0, 54583.18125228204, 81012.18987810047, 82608.58695706724, 83082.16917830745, 84473.0, 84576.57711711402, 13496.147812097028, 13569.796453053015, 14035.368408421442, 14037.1577705338, 14082.929585352007, 15764.921175394049, 15960.199203385933, 16058.669418863243, 16246.837531624533, 16543.172841358126, 13945.930270348583, 15438.5368438947, 15707.607309817346, 16781.412650557173, 16783.496495105166, 15072.0, 15294.923525382303, 15595.766063508829, 15849.841501584837, 16004.91997540005, 14502.85497145015, 14655.92672036633, 15157.545273641808, 15331.463398780988, 15359.69280614359, 12209.633710988684, 12257.570985015482, 12829.23024618526, 12841.357932103545, 13049.0, 12832.679183020125, 13090.869091308965, 13140.802887956497, 13414.396352163982, 13546.525871594447], "value": 8437.995084880888, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 102.0, 110.0, 110.0, 110.0, 97.0, 111.0, 110.0, 111.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 142.0, 183.0, 116.0, 152.0, 144.0, 122.0, 168.0, 119.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 163.0, 163.0, 162.0, 162.0, 162.0, 161.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 182.0, 77.0, 75.0, 79.0, 84.0, 182.0, 79.0], "value": 98.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 143.0, 83.0, 83.0, 85.0, 142.0, 84.0, 84.0, 148.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 121.0, 124.0, 120.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 53.0, 51.0, 52.0, 51.0, 51.0, 55.0, 51.0, 50.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 62.0, 64.0, 60.0, 61.0, 61.0, 61.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 82.0, 75.0, 77.0, 74.0, 72.0, 81.0, 77.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 128.0, 120.0, 118.0, 126.0, 117.0, 121.0, 153.0, 121.0], "value": 124.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 165.0, 162.0, 152.0, 155.0, 155.0, 158.0, 155.0, 150.0, 152.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 61.0, 63.0, 61.0, 61.0, 61.0, 61.0, 60.0], "value": 61.5, "unit": "score"}]}]} 07:47:50 INFO - Return code: 0 07:47:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:47:50 ERROR - # TBPL SUCCESS # 07:47:50 INFO - Running post-action listener: _resource_record_post_action 07:47:50 INFO - [mozharness: 2016-09-17 14:47:50.663228Z] Finished run-tests step (success) 07:47:50 INFO - Running post-run listener: _resource_record_post_run 07:47:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2736128; Write bytes: 329228288; Read time: 1076; Write time: 197092 07:47:50 INFO - TinderboxPrint: CPU usage
13.2% 07:47:50 INFO - TinderboxPrint: I/O read bytes / time
2,736,128 / 1,076 07:47:50 INFO - TinderboxPrint: I/O write bytes / time
329,228,288 / 197,092 07:47:50 INFO - TinderboxPrint: CPU idle
8,238.4 (86.8%) 07:47:50 INFO - TinderboxPrint: CPU user
1,197.7 (12.6%) 07:47:50 INFO - TinderboxPrint: Swap in / out
0 / 0 07:47:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79646720; Read time: 0; Write time: 63708 07:47:50 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 2732032; Write bytes: 249217024; Read time: 1060; Write time: 133308 07:47:51 INFO - Running post-run listener: _upload_blobber_files 07:47:51 INFO - Blob upload gear active. 07:47:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:47:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:47:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:47:51 INFO - (blobuploader) - INFO - Open directory for files ... 07:47:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:47:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:47:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:52 INFO - (blobuploader) - INFO - Done attempting. 07:47:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:47:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:47:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:53 INFO - (blobuploader) - INFO - Done attempting. 07:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:47:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:57 INFO - (blobuploader) - INFO - Done attempting. 07:47:57 INFO - (blobuploader) - INFO - Iteration through files over. 07:47:57 INFO - Return code: 0 07:47:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:47:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:47:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fa57ab11da55cfeeab6799eb71671f65435d61ef47ab2e3e776c9cd835d29051c8d4cc21ff48caef84e7c4b59af4232b0a80719ba4c2545272be17d2b849484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eadb201fc4ce9278254ef3a51d36a9d1fd5b4549fd36cfc79eb42585cbf4af2f5de53148a32396de52bdfe0ee447f2cf736dc0b47c7e8621e83642a53b19e4c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309a6bda2b90125779dfbdeb2a946b146a4c5f2af3d306716e5093b563cad1749e807a1450b99ac97b95550f0d0fc5f63d29d89b3e5f4aad3d18fff009cfe85b"} 07:47:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:47:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:47:57 INFO - Contents: 07:47:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fa57ab11da55cfeeab6799eb71671f65435d61ef47ab2e3e776c9cd835d29051c8d4cc21ff48caef84e7c4b59af4232b0a80719ba4c2545272be17d2b849484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eadb201fc4ce9278254ef3a51d36a9d1fd5b4549fd36cfc79eb42585cbf4af2f5de53148a32396de52bdfe0ee447f2cf736dc0b47c7e8621e83642a53b19e4c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309a6bda2b90125779dfbdeb2a946b146a4c5f2af3d306716e5093b563cad1749e807a1450b99ac97b95550f0d0fc5f63d29d89b3e5f4aad3d18fff009cfe85b"} 07:47:57 INFO - Running post-run listener: copy_logs_to_upload_dir 07:47:57 INFO - Copying logs to upload dir... 07:47:57 INFO - mkdir: /builds/slave/test/build/upload/logs 07:47:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.366924 ========= master_lag: 0.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-17 07:47:57.386289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 07:47:57.393415) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499 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/5fa57ab11da55cfeeab6799eb71671f65435d61ef47ab2e3e776c9cd835d29051c8d4cc21ff48caef84e7c4b59af4232b0a80719ba4c2545272be17d2b849484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eadb201fc4ce9278254ef3a51d36a9d1fd5b4549fd36cfc79eb42585cbf4af2f5de53148a32396de52bdfe0ee447f2cf736dc0b47c7e8621e83642a53b19e4c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309a6bda2b90125779dfbdeb2a946b146a4c5f2af3d306716e5093b563cad1749e807a1450b99ac97b95550f0d0fc5f63d29d89b3e5f4aad3d18fff009cfe85b"} build_url:https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/dEe2JI-8Qv2bXOdj8oNC1w/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/5fa57ab11da55cfeeab6799eb71671f65435d61ef47ab2e3e776c9cd835d29051c8d4cc21ff48caef84e7c4b59af4232b0a80719ba4c2545272be17d2b849484", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eadb201fc4ce9278254ef3a51d36a9d1fd5b4549fd36cfc79eb42585cbf4af2f5de53148a32396de52bdfe0ee447f2cf736dc0b47c7e8621e83642a53b19e4c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309a6bda2b90125779dfbdeb2a946b146a4c5f2af3d306716e5093b563cad1749e807a1450b99ac97b95550f0d0fc5f63d29d89b3e5f4aad3d18fff009cfe85b"}' ========= master_lag: 0.32 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 07:47:57.723322) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:47:57.723715) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1474121997.922056-1992594499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 07:47:57.743768) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 07:47:57.747169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 07:47:57.747519) ========= ========= Total master_lag: 1.07 =========