builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1471429310.95 results: success (0) buildid: 20160817004002 builduid: ac214529c8ca49288586448c943d48cf revision: fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:50.955002) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:50.955450) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:50.955765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.022056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.022525) ========= 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=337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 03:21:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-08-17 03:21:51 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160213 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.203583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.203892) ========= 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=337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.063111 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.279300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.279669) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 03:21:51,331 truncating revision to first 12 chars 2016-08-17 03:21:51,331 Setting DEBUG logging. 2016-08-17 03:21:51,331 attempt 1/10 2016-08-17 03:21:51,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fdc2f1d67e39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 03:21:51,667 unpacking tar archive at: mozilla-aurora-fdc2f1d67e39/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657414 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.952876) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.953209) ========= script_repo_revision: fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.953586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.953850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 03:21:51.964320) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-08-17 03:21:51.964588) ========= /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=337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:21:52 INFO - MultiFileLogger online at 20160817 03:21:52 in /builds/slave/test 03:21:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:21:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:52 INFO - {'append_to_log': False, 03:21:52 INFO - 'base_work_dir': '/builds/slave/test', 03:21:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:21:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:52 INFO - 'branch': 'Mozilla-Aurora', 03:21:52 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:52 INFO - 'config_files': ('talos/linux_config.py',), 03:21:52 INFO - 'default_actions': ('clobber', 03:21:52 INFO - 'read-buildbot-config', 03:21:52 INFO - 'download-and-extract', 03:21:52 INFO - 'populate-webroot', 03:21:52 INFO - 'create-virtualenv', 03:21:52 INFO - 'install', 03:21:52 INFO - 'run-tests'), 03:21:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:52 INFO - 'download_minidump_stackwalk': True, 03:21:52 INFO - 'download_symbols': 'ondemand', 03:21:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:52 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:52 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:52 INFO - 'installer_path': 'installer.exe', 03:21:52 INFO - 'log_level': 'info', 03:21:52 INFO - 'log_name': 'talos', 03:21:52 INFO - 'log_to_console': True, 03:21:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:21:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:21:52 INFO - 'opt_config_files': (), 03:21:52 INFO - 'pip_index': False, 03:21:52 INFO - 'sps_profile': False, 03:21:52 INFO - 'sps_profile_interval': 0, 03:21:52 INFO - 'suite': 'dromaeojs-e10s', 03:21:52 INFO - 'system_bits': '32', 03:21:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:52 INFO - 'title': 'talos-linux64-ix-060', 03:21:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:52 INFO - 'use_talos_json': True, 03:21:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:52 INFO - 'work_dir': 'build'} 03:21:52 INFO - [mozharness: 2016-08-17 10:21:52.219073Z] Running clobber step. 03:21:52 INFO - Running pre-action listener: _resource_record_pre_action 03:21:52 INFO - Running main action method: clobber 03:21:52 INFO - rmtree: /builds/slave/test/build 03:21:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:53 INFO - Running post-action listener: _resource_record_post_action 03:21:53 INFO - [mozharness: 2016-08-17 10:21:53.053159Z] Finished clobber step (success) 03:21:53 INFO - [mozharness: 2016-08-17 10:21:53.053394Z] Running read-buildbot-config step. 03:21:53 INFO - Running pre-action listener: _resource_record_pre_action 03:21:53 INFO - Running main action method: read_buildbot_config 03:21:53 INFO - Using buildbot properties: 03:21:53 INFO - { 03:21:53 INFO - "project": "", 03:21:53 INFO - "product": "firefox", 03:21:53 INFO - "script_repo_revision": "production", 03:21:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:21:53 INFO - "repository": "", 03:21:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:21:53 INFO - "buildid": "20160817004002", 03:21:53 INFO - "stage_platform": "linux64-pgo", 03:21:53 INFO - "basedir": "/builds/slave/test", 03:21:53 INFO - "nightly_build": "True", 03:21:53 INFO - "buildnumber": 470, 03:21:53 INFO - "slavename": "talos-linux64-ix-060", 03:21:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:21:53 INFO - "platform": "ubuntu64_hw", 03:21:53 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:21:53 INFO - "branch": "mozilla-aurora", 03:21:53 INFO - "repo_path": "releases/mozilla-aurora", 03:21:53 INFO - "revision": "fdc2f1d67e3977e4fbc79d0acbb32259eca0f524", 03:21:53 INFO - "pgo_build": "True", 03:21:53 INFO - "builduid": "ac214529c8ca49288586448c943d48cf", 03:21:53 INFO - "slavebuilddir": "test" 03:21:53 INFO - } 03:21:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:21:53 INFO - Running post-action listener: _resource_record_post_action 03:21:53 INFO - [mozharness: 2016-08-17 10:21:53.058914Z] Finished read-buildbot-config step (success) 03:21:53 INFO - [mozharness: 2016-08-17 10:21:53.059004Z] Running download-and-extract step. 03:21:53 INFO - Running pre-action listener: _resource_record_pre_action 03:21:53 INFO - Running main action method: download_and_extract 03:21:53 INFO - mkdir: /builds/slave/test/build/tests 03:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:53 INFO - https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:21:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:21:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:21:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:21:53 INFO - retry: Failed, sleeping 30 seconds before retrying 03:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:22:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:22:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:22:23 INFO - retry: Failed, sleeping 60 seconds before retrying 03:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:23:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:23:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 03:23:23 INFO - Caught exception: HTTP Error 404: Not Found 03:23:23 INFO - Caught exception: HTTP Error 404: Not Found 03:23:23 INFO - Caught exception: HTTP Error 404: Not Found 03:23:23 INFO - trying https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:23 INFO - Downloading https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:23:23 INFO - Downloaded 1361 bytes. 03:23:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:23 INFO - Using the following test package requirements: 03:23:23 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:23 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:23:23 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:23:23 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:23 INFO - u'jsshell-linux-x86_64.zip'], 03:23:23 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:23:23 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:23 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:23:23 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:23:23 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:23:23 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:23:23 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:23 INFO - https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:23:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:23:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:23:23 INFO - retry: Failed, sleeping 30 seconds before retrying 03:23:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:23:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:23:53 INFO - retry: Failed, sleeping 60 seconds before retrying 03:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:24:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:24:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:24:53 INFO - Caught exception: HTTP Error 404: Not Found 03:24:53 INFO - Caught exception: HTTP Error 404: Not Found 03:24:53 INFO - Caught exception: HTTP Error 404: Not Found 03:24:53 INFO - trying https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:53 INFO - Downloading https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:54 INFO - Downloaded 21836879 bytes. 03:24:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:24:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:24:55 INFO - Return code: 0 03:24:55 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:24: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')]} 03:24:55 INFO - https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:24:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:24:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:24:55 INFO - retry: Failed, sleeping 30 seconds before retrying 03:25:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:25:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:25:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:25:25 INFO - retry: Failed, sleeping 60 seconds before retrying 03:26:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:26:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:26:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:26:26 INFO - Caught exception: HTTP Error 404: Not Found 03:26:26 INFO - Caught exception: HTTP Error 404: Not Found 03:26:26 INFO - Caught exception: HTTP Error 404: Not Found 03:26:26 INFO - trying https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:26 INFO - Downloading https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:26:26 INFO - Downloaded 21836879 bytes. 03:26:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:26:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:26:28 INFO - Return code: 0 03:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:28 INFO - https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:26:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:26:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:26:28 INFO - retry: Failed, sleeping 30 seconds before retrying 03:26:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:26:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:26:58 INFO - retry: Failed, sleeping 60 seconds before retrying 03:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:27:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:27:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 03:27:58 INFO - Caught exception: HTTP Error 404: Not Found 03:27:58 INFO - Caught exception: HTTP Error 404: Not Found 03:27:58 INFO - Caught exception: HTTP Error 404: Not Found 03:27:58 INFO - trying https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:58 INFO - Downloading https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:27:59 INFO - Downloaded 14413723 bytes. 03:27:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:27:59 INFO - Return code: 0 03: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')]} 03:27:59 INFO - https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:27:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:27:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:27:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:27:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:27:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:27:59 INFO - retry: Failed, sleeping 30 seconds before retrying 03:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:28:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:28:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:28:29 INFO - retry: Failed, sleeping 60 seconds before retrying 03:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:29:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:29:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 03:29:29 INFO - Caught exception: HTTP Error 404: Not Found 03:29:29 INFO - Caught exception: HTTP Error 404: Not Found 03:29:29 INFO - Caught exception: HTTP Error 404: Not Found 03:29:29 INFO - trying https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:29 INFO - Downloading https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:29:31 INFO - Downloaded 63781116 bytes. 03:29:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:31 INFO - mkdir: /builds/slave/test/properties 03:29:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:31 INFO - Contents: 03:29:31 INFO - build_url:https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:32 INFO - Running post-action listener: _resource_record_post_action 03:29:32 INFO - Running post-action listener: set_extra_try_arguments 03:29:32 INFO - [mozharness: 2016-08-17 10:29:32.036383Z] Finished download-and-extract step (success) 03:29:32 INFO - [mozharness: 2016-08-17 10:29:32.036617Z] Running populate-webroot step. 03:29:32 INFO - Running pre-action listener: _resource_record_pre_action 03:29:32 INFO - Running main action method: populate_webroot 03:29:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:29:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:29:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:29:32 INFO - '--tppagecycles', 03:29:32 INFO - '7'], 03:29:32 INFO - 'tests': ['tsvgm']}}, 03:29:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:29:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:29:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:32 INFO - 'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:32 INFO - 'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['damp', 'tps']}, 03:29:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:32 INFO - 'tests': ['damp', 'tps']}, 03:29:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['dromaeo_dom']}, 03:29:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['basic_compositor_video']}, 03:29:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:29:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['a11yr', 03:29:32 INFO - 'ts_paint', 03:29:32 INFO - 'tpaint', 03:29:32 INFO - 'sessionrestore', 03:29:32 INFO - 'sessionrestore_no_auto_restore', 03:29:32 INFO - 'tabpaint']}, 03:29:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:32 INFO - 'ts_paint', 03:29:32 INFO - 'tpaint', 03:29:32 INFO - 'sessionrestore', 03:29:32 INFO - 'sessionrestore_no_auto_restore', 03:29:32 INFO - 'tabpaint']}, 03:29:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:29:32 INFO - 'ts_paint', 03:29:32 INFO - 'tpaint', 03:29:32 INFO - 'sessionrestore', 03:29:32 INFO - 'sessionrestore_no_auto_restore', 03:29:32 INFO - 'tabpaint']}, 03:29:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:29:32 INFO - 'ts_paint', 03:29:32 INFO - 'tpaint', 03:29:32 INFO - 'sessionrestore', 03:29:32 INFO - 'sessionrestore_no_auto_restore', 03:29:32 INFO - 'tabpaint']}, 03:29:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['a11yr', 03:29:32 INFO - 'ts_paint', 03:29:32 INFO - 'tpaint', 03:29:32 INFO - 'sessionrestore', 03:29:32 INFO - 'sessionrestore_no_auto_restore', 03:29:32 INFO - 'tabpaint']}, 03:29:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['a11yr', 03:29:32 INFO - 'ts_paint', 03:29:32 INFO - 'tpaint', 03:29:32 INFO - 'sessionrestore', 03:29:32 INFO - 'sessionrestore_no_auto_restore', 03:29:32 INFO - 'tabpaint']}, 03:29:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['tsvgx', 03:29:32 INFO - 'tsvgr_opacity', 03:29:32 INFO - 'tart', 03:29:32 INFO - 'tscrollx', 03:29:32 INFO - 'cart']}, 03:29:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:32 INFO - 'tsvgr_opacity', 03:29:32 INFO - 'tart', 03:29:32 INFO - 'tscrollx', 03:29:32 INFO - 'cart']}, 03:29:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:32 INFO - 'talos_options': ['--disable-e10s'], 03:29:32 INFO - 'tests': ['tp5o']}, 03:29:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:32 INFO - 'tests': ['tp5o']}, 03:29:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:32 INFO - 'talos_options': ['--disable-e10s', 03:29:32 INFO - '--xperf_path', 03:29:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:32 INFO - 'tests': ['tp5n']}, 03:29:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:32 INFO - 'talos_options': ['--xperf_path', 03:29:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:32 INFO - 'tests': ['tp5n']}}, 03:29:32 INFO - 'talos.zip': {'path': '', 03:29:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:29:32 INFO - Running post-action listener: _resource_record_post_action 03:29:32 INFO - [mozharness: 2016-08-17 10:29:32.056086Z] Finished populate-webroot step (success) 03:29:32 INFO - [mozharness: 2016-08-17 10:29:32.056176Z] Running create-virtualenv step. 03:29:32 INFO - Running pre-action listener: _resource_record_pre_action 03:29:32 INFO - Running main action method: create_virtualenv 03:29:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:29:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:29:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:32 INFO - Using real prefix '/usr' 03:29:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:34 INFO - Installing pip.................done. 03:29:34 INFO - Return code: 0 03:29:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:34 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 0xde5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:29:34 INFO - Using env: {'DISPLAY': ':0', 03:29:34 INFO - 'HOME': '/home/cltbld', 03:29:34 INFO - 'LANG': 'en_US.UTF-8', 03:29:34 INFO - 'LANGUAGE': 'en_US:en', 03:29:34 INFO - 'LOGNAME': 'cltbld', 03:29:34 INFO - 'MAIL': '/var/mail/cltbld', 03:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:34 INFO - 'MOZ_NO_REMOTE': '1', 03:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:34 INFO - 'NO_EM_RESTART': '1', 03:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:34 INFO - 'PWD': '/builds/slave/test', 03:29:34 INFO - 'SHELL': '/bin/bash', 03:29:34 INFO - 'SHLVL': '1', 03:29:34 INFO - 'TERM': 'linux', 03:29:34 INFO - 'TMOUT': '86400', 03:29:34 INFO - 'USER': 'cltbld', 03:29:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:34 INFO - '_': '/tools/buildbot/bin/python'} 03:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:29:35 INFO - Cleaning up... 03:29:35 INFO - Return code: 0 03:29:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:35 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 0xde5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:29:35 INFO - Using env: {'DISPLAY': ':0', 03:29:35 INFO - 'HOME': '/home/cltbld', 03:29:35 INFO - 'LANG': 'en_US.UTF-8', 03:29:35 INFO - 'LANGUAGE': 'en_US:en', 03:29:35 INFO - 'LOGNAME': 'cltbld', 03:29:35 INFO - 'MAIL': '/var/mail/cltbld', 03:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:35 INFO - 'MOZ_NO_REMOTE': '1', 03:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:35 INFO - 'NO_EM_RESTART': '1', 03:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:35 INFO - 'PWD': '/builds/slave/test', 03:29:35 INFO - 'SHELL': '/bin/bash', 03:29:35 INFO - 'SHLVL': '1', 03:29:35 INFO - 'TERM': 'linux', 03:29:35 INFO - 'TMOUT': '86400', 03:29:35 INFO - 'USER': 'cltbld', 03:29:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:35 INFO - '_': '/tools/buildbot/bin/python'} 03:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:35 INFO - Downloading/unpacking psutil>=3.1.1 03:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:37 INFO - Installing collected packages: psutil 03:29:37 INFO - Running setup.py install for psutil 03:29:37 INFO - building 'psutil._psutil_linux' extension 03:29:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:29:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:29:38 INFO - building 'psutil._psutil_posix' extension 03:29:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:29:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:29:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:38 INFO - Successfully installed psutil 03:29:38 INFO - Cleaning up... 03:29:38 INFO - Return code: 0 03:29:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:38 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 0xde5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:29:38 INFO - Using env: {'DISPLAY': ':0', 03:29:38 INFO - 'HOME': '/home/cltbld', 03:29:38 INFO - 'LANG': 'en_US.UTF-8', 03:29:38 INFO - 'LANGUAGE': 'en_US:en', 03:29:38 INFO - 'LOGNAME': 'cltbld', 03:29:38 INFO - 'MAIL': '/var/mail/cltbld', 03:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:38 INFO - 'MOZ_NO_REMOTE': '1', 03:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:38 INFO - 'NO_EM_RESTART': '1', 03:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:38 INFO - 'PWD': '/builds/slave/test', 03:29:38 INFO - 'SHELL': '/bin/bash', 03:29:38 INFO - 'SHLVL': '1', 03:29:38 INFO - 'TERM': 'linux', 03:29:38 INFO - 'TMOUT': '86400', 03:29:38 INFO - 'USER': 'cltbld', 03:29:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:38 INFO - '_': '/tools/buildbot/bin/python'} 03:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:29:40 INFO - Installing collected packages: mozsystemmonitor 03:29:40 INFO - Running setup.py install for mozsystemmonitor 03:29:41 INFO - Successfully installed mozsystemmonitor 03:29:41 INFO - Cleaning up... 03:29:41 INFO - Return code: 0 03:29:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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', '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 0xde5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:29: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 jsonschema==2.5.1 03:29:41 INFO - Using env: {'DISPLAY': ':0', 03:29:41 INFO - 'HOME': '/home/cltbld', 03:29:41 INFO - 'LANG': 'en_US.UTF-8', 03:29:41 INFO - 'LANGUAGE': 'en_US:en', 03:29:41 INFO - 'LOGNAME': 'cltbld', 03:29:41 INFO - 'MAIL': '/var/mail/cltbld', 03:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:41 INFO - 'MOZ_NO_REMOTE': '1', 03:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:41 INFO - 'NO_EM_RESTART': '1', 03:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:41 INFO - 'PWD': '/builds/slave/test', 03:29:41 INFO - 'SHELL': '/bin/bash', 03:29:41 INFO - 'SHLVL': '1', 03:29:41 INFO - 'TERM': 'linux', 03:29:41 INFO - 'TMOUT': '86400', 03:29:41 INFO - 'USER': 'cltbld', 03:29:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:41 INFO - '_': '/tools/buildbot/bin/python'} 03:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:41 INFO - Downloading/unpacking jsonschema==2.5.1 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:43 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:43 INFO - warning: no files found matching '*.txt' 03:29:43 INFO - no previously-included directories found matching 'build' 03:29:43 INFO - no previously-included directories found matching 'dist' 03:29:43 INFO - no previously-included directories found matching '.git*' 03:29:43 INFO - Installing collected packages: jsonschema, functools32 03:29:43 INFO - Running setup.py install for functools32 03:29:43 INFO - warning: no files found matching '*.txt' 03:29:43 INFO - no previously-included directories found matching 'build' 03:29:43 INFO - no previously-included directories found matching 'dist' 03:29:43 INFO - no previously-included directories found matching '.git*' 03:29:43 INFO - Successfully installed jsonschema functools32 03:29:43 INFO - Cleaning up... 03:29:43 INFO - Return code: 0 03:29:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xde5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:29:43 INFO - Using env: {'DISPLAY': ':0', 03:29:43 INFO - 'HOME': '/home/cltbld', 03:29:43 INFO - 'LANG': 'en_US.UTF-8', 03:29:43 INFO - 'LANGUAGE': 'en_US:en', 03:29:43 INFO - 'LOGNAME': 'cltbld', 03:29:43 INFO - 'MAIL': '/var/mail/cltbld', 03:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:43 INFO - 'MOZ_NO_REMOTE': '1', 03:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:43 INFO - 'NO_EM_RESTART': '1', 03:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:43 INFO - 'PWD': '/builds/slave/test', 03:29:43 INFO - 'SHELL': '/bin/bash', 03:29:43 INFO - 'SHLVL': '1', 03:29:43 INFO - 'TERM': 'linux', 03:29:43 INFO - 'TMOUT': '86400', 03:29:43 INFO - 'USER': 'cltbld', 03:29:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:43 INFO - '_': '/tools/buildbot/bin/python'} 03:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:29:43 INFO - Cleaning up... 03:29:43 INFO - Return code: 0 03:29:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xde5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:29:43 INFO - Using env: {'DISPLAY': ':0', 03:29:43 INFO - 'HOME': '/home/cltbld', 03:29:43 INFO - 'LANG': 'en_US.UTF-8', 03:29:43 INFO - 'LANGUAGE': 'en_US:en', 03:29:43 INFO - 'LOGNAME': 'cltbld', 03:29:43 INFO - 'MAIL': '/var/mail/cltbld', 03:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:43 INFO - 'MOZ_NO_REMOTE': '1', 03:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:43 INFO - 'NO_EM_RESTART': '1', 03:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:43 INFO - 'PWD': '/builds/slave/test', 03:29:43 INFO - 'SHELL': '/bin/bash', 03:29:43 INFO - 'SHLVL': '1', 03:29:43 INFO - 'TERM': 'linux', 03:29:43 INFO - 'TMOUT': '86400', 03:29:43 INFO - 'USER': 'cltbld', 03:29:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:43 INFO - '_': '/tools/buildbot/bin/python'} 03:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:44 INFO - Downloading/unpacking blobuploader==1.2.4 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29:46 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29:46 INFO - Downloading docopt-0.6.1.tar.gz 03:29:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:46 INFO - Running setup.py install for blobuploader 03:29:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:46 INFO - Running setup.py install for requests 03:29:47 INFO - Running setup.py install for docopt 03:29:47 INFO - Successfully installed blobuploader requests docopt 03:29:47 INFO - Cleaning up... 03:29:47 INFO - Return code: 0 03:29:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:47 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 0xde5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:47 INFO - Using env: {'DISPLAY': ':0', 03:29:47 INFO - 'HOME': '/home/cltbld', 03:29:47 INFO - 'LANG': 'en_US.UTF-8', 03:29:47 INFO - 'LANGUAGE': 'en_US:en', 03:29:47 INFO - 'LOGNAME': 'cltbld', 03:29:47 INFO - 'MAIL': '/var/mail/cltbld', 03:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:47 INFO - 'MOZ_NO_REMOTE': '1', 03:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:47 INFO - 'NO_EM_RESTART': '1', 03:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:47 INFO - 'PWD': '/builds/slave/test', 03:29:47 INFO - 'SHELL': '/bin/bash', 03:29:47 INFO - 'SHLVL': '1', 03:29:47 INFO - 'TERM': 'linux', 03:29:47 INFO - 'TMOUT': '86400', 03:29:47 INFO - 'USER': 'cltbld', 03:29:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:47 INFO - '_': '/tools/buildbot/bin/python'} 03:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:47 INFO - Running setup.py (path:/tmp/pip-KBoyuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:47 INFO - Running setup.py (path:/tmp/pip-EKhDLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:47 INFO - Running setup.py (path:/tmp/pip-DmzNjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:47 INFO - Running setup.py (path:/tmp/pip-dOrrg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:47 INFO - Running setup.py (path:/tmp/pip-ZOopHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:47 INFO - Running setup.py (path:/tmp/pip-BvjKXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:48 INFO - Running setup.py (path:/tmp/pip-ubu9EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:48 INFO - Running setup.py (path:/tmp/pip-7ZKkLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:48 INFO - Running setup.py (path:/tmp/pip-Ouhl0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:48 INFO - Running setup.py (path:/tmp/pip-wkOeeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:48 INFO - Running setup.py (path:/tmp/pip-I1j_wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:48 INFO - Running setup.py (path:/tmp/pip-krAqdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:48 INFO - Running setup.py (path:/tmp/pip-IziXOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:48 INFO - Running setup.py (path:/tmp/pip-Dq4aSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:48 INFO - Running setup.py (path:/tmp/pip-DUmR7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:48 INFO - Running setup.py (path:/tmp/pip-dmandM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:48 INFO - Running setup.py (path:/tmp/pip-MSIOT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:48 INFO - Running setup.py install for manifestparser 03:29:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:48 INFO - Running setup.py install for mozcrash 03:29:49 INFO - Running setup.py install for mozdebug 03:29:49 INFO - Running setup.py install for mozdevice 03:29:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:29:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:49 INFO - Running setup.py install for mozfile 03:29:49 INFO - Running setup.py install for mozhttpd 03:29:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:49 INFO - Running setup.py install for mozinfo 03:29:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:49 INFO - Running setup.py install for mozInstall 03:29:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:49 INFO - Running setup.py install for mozleak 03:29:49 INFO - Running setup.py install for mozlog 03:29:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:49 INFO - Running setup.py install for moznetwork 03:29:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:49 INFO - Running setup.py install for mozprocess 03:29:50 INFO - Running setup.py install for mozprofile 03:29:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:50 INFO - Running setup.py install for mozrunner 03:29:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:50 INFO - Running setup.py install for mozscreenshot 03:29:50 INFO - Running setup.py install for moztest 03:29:50 INFO - Running setup.py install for mozversion 03:29:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:50 INFO - Cleaning up... 03:29:50 INFO - Return code: 0 03:29:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:50 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 0xde5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:50 INFO - Using env: {'DISPLAY': ':0', 03:29:50 INFO - 'HOME': '/home/cltbld', 03:29:50 INFO - 'LANG': 'en_US.UTF-8', 03:29:50 INFO - 'LANGUAGE': 'en_US:en', 03:29:50 INFO - 'LOGNAME': 'cltbld', 03:29:50 INFO - 'MAIL': '/var/mail/cltbld', 03:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:50 INFO - 'MOZ_NO_REMOTE': '1', 03:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:50 INFO - 'NO_EM_RESTART': '1', 03:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:50 INFO - 'PWD': '/builds/slave/test', 03:29:50 INFO - 'SHELL': '/bin/bash', 03:29:50 INFO - 'SHLVL': '1', 03:29:50 INFO - 'TERM': 'linux', 03:29:50 INFO - 'TMOUT': '86400', 03:29:50 INFO - 'USER': 'cltbld', 03:29:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:50 INFO - '_': '/tools/buildbot/bin/python'} 03:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:50 INFO - Running setup.py (path:/tmp/pip-u2eFh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:50 INFO - Running setup.py (path:/tmp/pip-N4TUZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:50 INFO - Running setup.py (path:/tmp/pip-BF5ous-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:51 INFO - Running setup.py (path:/tmp/pip-2UFLd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:51 INFO - Running setup.py (path:/tmp/pip-_562W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:51 INFO - Running setup.py (path:/tmp/pip-eu_HxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:51 INFO - Running setup.py (path:/tmp/pip-QvK9BW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:51 INFO - Running setup.py (path:/tmp/pip-zrwVDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:51 INFO - Running setup.py (path:/tmp/pip-mZgogf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:51 INFO - Running setup.py (path:/tmp/pip-hi0c6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:51 INFO - Running setup.py (path:/tmp/pip-lx0r5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:51 INFO - Running setup.py (path:/tmp/pip-vV6RYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:51 INFO - Running setup.py (path:/tmp/pip-k4SC0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:51 INFO - Running setup.py (path:/tmp/pip-Oxfnug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:51 INFO - Running setup.py (path:/tmp/pip-lE2EHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:51 INFO - Running setup.py (path:/tmp/pip-eDMiwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:51 INFO - Running setup.py (path:/tmp/pip-yIjdN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:53 INFO - Downloading blessings-1.6.tar.gz 03:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:54 INFO - Installing collected packages: blessings 03:29:54 INFO - Running setup.py install for blessings 03:29:54 INFO - Successfully installed blessings 03:29:54 INFO - Cleaning up... 03:29:54 INFO - Return code: 0 03:29:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:54 INFO - Reading from file tmpfile_stdout 03:29:54 INFO - Current package versions: 03:29:54 INFO - argparse == 1.2.1 03:29:54 INFO - blessings == 1.6 03:29:54 INFO - blobuploader == 1.2.4 03:29:54 INFO - docopt == 0.6.1 03:29:54 INFO - functools32 == 3.2.3-2 03:29:54 INFO - jsonschema == 2.5.1 03:29:54 INFO - manifestparser == 1.1 03:29:54 INFO - mozInstall == 1.12 03:29:54 INFO - mozcrash == 0.17 03:29:54 INFO - mozdebug == 0.1 03:29:54 INFO - mozdevice == 0.48 03:29:54 INFO - mozfile == 1.2 03:29:54 INFO - mozhttpd == 0.7 03:29:54 INFO - mozinfo == 0.9 03:29:54 INFO - mozleak == 0.1 03:29:54 INFO - mozlog == 3.3 03:29:54 INFO - moznetwork == 0.27 03:29:54 INFO - mozprocess == 0.23 03:29:54 INFO - mozprofile == 0.28 03:29:54 INFO - mozrunner == 6.12 03:29:54 INFO - mozscreenshot == 0.1 03:29:54 INFO - mozsystemmonitor == 0.3 03:29:54 INFO - moztest == 0.7 03:29:54 INFO - mozversion == 1.4 03:29:54 INFO - psutil == 3.1.1 03:29:54 INFO - requests == 1.2.3 03:29:54 INFO - wsgiref == 0.1.2 03:29:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:54 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 0xde5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:54 INFO - Using env: {'DISPLAY': ':0', 03:29:54 INFO - 'HOME': '/home/cltbld', 03:29:54 INFO - 'LANG': 'en_US.UTF-8', 03:29:54 INFO - 'LANGUAGE': 'en_US:en', 03:29:54 INFO - 'LOGNAME': 'cltbld', 03:29:54 INFO - 'MAIL': '/var/mail/cltbld', 03:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:54 INFO - 'MOZ_NO_REMOTE': '1', 03:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:54 INFO - 'NO_EM_RESTART': '1', 03:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:54 INFO - 'PWD': '/builds/slave/test', 03:29:54 INFO - 'SHELL': '/bin/bash', 03:29:54 INFO - 'SHLVL': '1', 03:29:54 INFO - 'TERM': 'linux', 03:29:54 INFO - 'TMOUT': '86400', 03:29:54 INFO - 'USER': 'cltbld', 03:29:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:54 INFO - '_': '/tools/buildbot/bin/python'} 03:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:54 INFO - Cleaning up... 03:29:54 INFO - Return code: 0 03:29:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:54 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 0xde5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, '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': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:29:54 INFO - Using env: {'DISPLAY': ':0', 03:29:54 INFO - 'HOME': '/home/cltbld', 03:29:54 INFO - 'LANG': 'en_US.UTF-8', 03:29:54 INFO - 'LANGUAGE': 'en_US:en', 03:29:54 INFO - 'LOGNAME': 'cltbld', 03:29:54 INFO - 'MAIL': '/var/mail/cltbld', 03:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:54 INFO - 'MOZ_NO_REMOTE': '1', 03:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:54 INFO - 'NO_EM_RESTART': '1', 03:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:54 INFO - 'PWD': '/builds/slave/test', 03:29:54 INFO - 'SHELL': '/bin/bash', 03:29:54 INFO - 'SHLVL': '1', 03:29:54 INFO - 'TERM': 'linux', 03:29:54 INFO - 'TMOUT': '86400', 03:29:54 INFO - 'USER': 'cltbld', 03:29:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:54 INFO - '_': '/tools/buildbot/bin/python'} 03:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:29:54 INFO - Cleaning up... 03:29:54 INFO - Return code: 0 03:29:54 INFO - Running post-action listener: _resource_record_post_action 03:29:54 INFO - Running post-action listener: _start_resource_monitoring 03:29:54 INFO - Starting resource monitoring. 03:29:54 INFO - [mozharness: 2016-08-17 10:29:54.865714Z] Finished create-virtualenv step (success) 03:29:54 INFO - [mozharness: 2016-08-17 10:29:54.866696Z] Running install step. 03:29:54 INFO - Running pre-action listener: _resource_record_pre_action 03:29:54 INFO - Running main action method: install 03:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:55 INFO - Reading from file tmpfile_stdout 03:29:55 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:55 INFO - Reading from file tmpfile_stdout 03:29:55 INFO - Output received: 03:29:55 INFO - Usage: mozinstall [options] installer 03:29:55 INFO - Options: 03:29:55 INFO - -h, --help show this help message and exit 03:29:55 INFO - -d DEST, --destination=DEST 03:29:55 INFO - Directory to install application into. [default: 03:29:55 INFO - "/builds/slave/test"] 03:29:55 INFO - --app=APP Application being installed. [default: firefox] 03:29:55 INFO - mkdir: /builds/slave/test/build/application 03:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:30:11 INFO - Reading from file tmpfile_stdout 03:30:11 INFO - Output received: 03:30:11 INFO - /builds/slave/test/build/application/firefox/firefox 03:30:11 INFO - Running post-action listener: _resource_record_post_action 03:30:11 INFO - [mozharness: 2016-08-17 10:30:11.130480Z] Finished install step (success) 03:30:11 INFO - [mozharness: 2016-08-17 10:30:11.130760Z] Running run-tests step. 03:30:11 INFO - Running pre-action listener: _resource_record_pre_action 03:30:11 INFO - Running main action method: run_tests 03:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:30:11 INFO - Python 2.7.3 03:30:11 INFO - Return code: 0 03:30:11 INFO - grabbing minidump binary from tooltool 03:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:11 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 0x10a3570>, '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 0x10a4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:30:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:30:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:30:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:30:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:11 INFO - Return code: 0 03:30:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:30:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:30:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:30:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:30:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:30:11 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/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:30:11 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/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:30:11 INFO - Using env: {'DISPLAY': ':0', 03:30:11 INFO - 'HOME': '/home/cltbld', 03:30:11 INFO - 'LANG': 'en_US.UTF-8', 03:30:11 INFO - 'LANGUAGE': 'en_US:en', 03:30:11 INFO - 'LOGNAME': 'cltbld', 03:30:11 INFO - 'MAIL': '/var/mail/cltbld', 03:30:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:11 INFO - 'MOZ_NO_REMOTE': '1', 03:30:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:11 INFO - 'NO_EM_RESTART': '1', 03:30:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:11 INFO - 'PWD': '/builds/slave/test', 03:30:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:11 INFO - 'SHELL': '/bin/bash', 03:30:11 INFO - 'SHLVL': '1', 03:30:11 INFO - 'TERM': 'linux', 03:30:11 INFO - 'TMOUT': '86400', 03:30:11 INFO - 'USER': 'cltbld', 03:30:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499', 03:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:11 INFO - '_': '/tools/buildbot/bin/python'} 03:30:11 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/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:30:11 INFO - mozversion application_buildid: 20160817004002 03:30:11 INFO - mozversion application_changeset: fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 03:30:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:30:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:30:11 INFO - mozversion application_name: Firefox 03:30:11 INFO - mozversion application_remotingname: firefox-dev 03:30:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:30:11 INFO - mozversion application_vendor: Mozilla 03:30:11 INFO - mozversion application_version: 50.0a2 03:30:11 INFO - mozversion platform_buildid: 20160817004002 03:30:11 INFO - mozversion platform_changeset: fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 03:30:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:30:11 INFO - mozversion platform_version: 50.0a2 03:30:11 INFO - using testdate: 1471429811 03:30:11 INFO - actual date: 1471429811 03:30:11 INFO - starting webserver on 'localhost:55304' 03:30:11 INFO - SUITE-START | Running 2 tests 03:30:11 INFO - TEST-START | dromaeo_css 03:30:11 INFO - operating with platform_type : linux_ 03:30:11 INFO - Initialising browser for dromaeo_css test... 03:30:11 INFO - TEST-INFO | started process 3332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwfVel_/profile http://localhost:55304/getInfo.html) 03:30:17 INFO - PROCESS | 3332 | __metrics Screen width/height:1600/1200 03:30:17 INFO - PROCESS | 3332 | colorDepth:24 03:30:17 INFO - PROCESS | 3332 | Browser inner width/height: 1024/697 03:30:17 INFO - PROCESS | 3332 | __metrics 03:30:18 ERROR - PROCESS | 3332 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:30:19 INFO - TEST-INFO | 3332: exit 0 03:30:19 INFO - Browser initialized. 03:30:19 INFO - Running cycle 1/1 for dromaeo_css test... 03:30:19 INFO - TEST-INFO | started process 3460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwfVel_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:30 INFO - PROCESS | 3460 | RSS: Main: 152952832 03:30:30 INFO - PROCESS | 3460 | 03:31:20 INFO - PROCESS | 3460 | 1471429880469 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:33:28 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55304/tests/dromaeo/cssquery-ext.html) 03:33:29 INFO - PROCESS | 3460 | RSS: Main: 158191616 03:33:29 INFO - PROCESS | 3460 | 03:36:31 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55304/tests/dromaeo/cssquery-ext.html (next: http://localhost:55304/tests/dromaeo/cssquery-jquery.html) 03:36:32 INFO - PROCESS | 3460 | RSS: Main: 153985024 03:36:32 INFO - PROCESS | 3460 | 03:39:34 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55304/tests/dromaeo/cssquery-mootools.html) 03:39:35 INFO - PROCESS | 3460 | RSS: Main: 154025984 03:39:35 INFO - PROCESS | 3460 | 03:42:36 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55304/tests/dromaeo/cssquery-prototype.html) 03:42:37 INFO - PROCESS | 3460 | RSS: Main: 153272320 03:42:37 INFO - PROCESS | 3460 | 03:45:40 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55304/tests/dromaeo/cssquery-yui.html) 03:45:40 INFO - PROCESS | 3460 | RSS: Main: 155217920 03:45:40 INFO - PROCESS | 3460 | 03:48:43 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55304/tests/dromaeo/cssquery-yui.html (next: http://localhost:55304/tests/dromaeo/cssquery-dojo.html) 03:48:43 INFO - PROCESS | 3460 | RSS: Main: 155435008 03:48:43 INFO - PROCESS | 3460 | 03:48:43 INFO - PROCESS | 3460 | __start_tp_report 03:48:43 INFO - PROCESS | 3460 | _x_x_mozilla_page_load 03:48:43 INFO - PROCESS | 3460 | _x_x_mozilla_page_load_details 03:48:43 INFO - PROCESS | 3460 | |i|pagename|runs| 03:48:43 INFO - PROCESS | 3460 | |0;dojo.html;3284.7536434767394;3349.380364632543;3354.580677415324;3366.5455163552915;3371.157210697326;5651.350094739107;5714.599978001542;5723.570732195087;5724.198612194296;5739.253896993385;5649.096144616862;5780.653160810354;5788.334341550712;5803.854903627412;5828.883422331562;5078.289039534468;5200.297959775429;5222.3472065991755;5285.075111855429;5296.417394086648;5113.769880355374;5150.484951504838;5197.948020519803;5216.634835561512;5276.182191760264;5208.062548741244;5232.686038837663;5243.764030618612;5251.894962100756;5292.179712144623;5272.23552584875;5281.118377992173;5292.126799078128;5293.947060529384;5311.973440132774;4968.826091086795;5029.245613158019;5049.091163590552;5189.091908915962;5214.296070030536;5600.887982240373;5628.296462942132;5657.066584013633;5664.461876121762;5684.175794509814;6021.5182785377065;6025.849353766147;6061.848453788646;6070.423309785563;6082.513398928075;5979.342272350038;6060.515158787286;6123.2039834821635;6127.050307202391;6127.632342059491;5756.079027355603;5756.165356023395;5771.8557036074435;5784.508316793078;5801.680907550125;6306.211723534559;6333.873322533524;6338.176037115146;6342.112104305401;6345.714442850082;5786.392428795;5955.910661339996;6001.819945401645;6065.939340606626;6083.300420451616;6100.908486372708;6136.1821086261625;6137.9286238596105;6143.174139895698;6151.569390142647;6088.11722300264;6099.69501524922;6101.877962440815;6104.511639068864;6107.389261073946;5882.941170588325;5980.760769569169;6022.45797878193;6046.395360464006;6126.479249263773;4671.299305104194;4683.086798074342;4686.7656617169005;4698.342232087442;4707.976460117678;4182.728122672017;4186.518550366686;4186.958130418657;4193.727407718488;4204.159168166379;5636.689982050944;5781.855453613609;5788.971055144697;5865.442782935615;5882.794102206488;6116.067872221748;6118.4059889896;6126.077532388462;6137.070562331796;6155.72299246535;5828.6502809831545;5874.148248503943;5897.174395584621;5906;5909.940900591025;5033.370828646419;5159.355080614923;5239.633225674166;5240.318758561362;5306.6550674206055;6321.209848768904;6346.17499725042;6349.873002539924;6350.904736428957;6391.105245265667;6076.817695469143;6083.330833608388;6087.4521293083835;6093.634381937098;6116.66358350295;6100.23747031621;6222.377762223741;6253.78111766086;6287.339829318039;6335.208098987627;5993.9700301498215;6028.969855150696;6032.849178770566;6041.78853740117;6076.088586712029;6126.23422072241;6129.509639228941;6133.294671112701;6135.509159267337;6166.969165154145;5824.184614154106;5938.317093534299;5964.761409543569;5990.041593345044;6000.459958603572;5972.223610930551;5977.5217982560425;5988.461038506555;6004.909926351021;6025.578209525291;5897.882042359214;5965.880682386415;5967.403259674172;5978.3423823378525;5979.222701048836;5792.942070579409;5890.9116363253725;5893.5874488785375;5974.2830860297045;5976.462118409364;5873.706314684334;5878.676672783038;5878.941210587839;5905.261842269716;5907.616004959664 03:48:43 INFO - PROCESS | 3460 | |1;ext.html;581.9243498345214;611.8042226487523;643.6781609195406;649.8700259948012;670.8222321084917;40440;44563.77718111405;44676.77661611696;44732.32901506476;44755.328670069975;45546.77226613862;46349.768251158785;46357.53642463574;46439.76780116103;46488.07023859521;8986.056464071293;9117.726468205965;9188.724338269829;9196.080391960817;9198.494082825475;9104.63581456741;9139.634414623408;9171.816563668723;9210.815783684322;9212.124848139416;9233.58448869799;9265.25877929764;9266.490343031131;9267.72196834096;9274.907250927505;9218.492982885939;9229.815403691922;9262.6294948202;9265.629374825;9302.674406395743;9051.366404351633;9118.179363857218;9129.132732390412;9132.406393584395;9137.634494620273;42703.57296427027;43340;43372.783136084436;43381.78309108434;43489.56510434887;3110.9533356999664;3553.4136867416846;3784.564775050877;3786.0345611869075;3828.062124779419;33582.83208583966;33887.66112338894;34061.318773624385;34106;34452.65547344519;4061.695372847019;4072.2873497137884;4100.5899410058755;4152.356384760367;4161.2301724181125;332655;332760;334155;334603.326983366;335328;34237.31525369479;39393.80303098523;39506.209875802895;39629.40555891664;39790.80104599459;40668;40764;40871.18257634831;40875;40913.79543102325;16856.494305170865;16870.831291687173;16911.069891156105;16915.57711057209;16938;13349.199048057148;13572.864271357357;13574.59276221715;13591.116577422634;13683.384247708877;9185.081491850762;9249;9257.537123143951;9258.67594634198;9338.953305233566;3521.7182625389905;3547.6629720177057;3558.5551806024246;3562.2163124112653;3562.4300111981956;1099.263493459384;1123.533843214137;1123.775244951013;1139.6694958461953;1227.2881728597392;34141;34705.091219983144;34724.82941509484;34732.65267347294;34829.825850870584;1174.9588764393204;1175.782480241158;1192.80915053591;1222.9694257643453;1261.1613277170761;17940.282388704305;18010.63978720418;18091.185896634684;18212.180451879696;18274.54313642143;622759;624742;626645;628736;629140;64258;64352;65162.67418662876;65242;65497.01754473687;1424.309210033133;1445.9204743739194;1450.9492167774076;1460.5326295585523;1466.6993266380366;31259.84370078135;33365.666343336256;33505;34123.829380852934;34497;61602;62734.37265627468;62856.68571657295;69038.30961690319;69542;552133;553495;553829;557727;563146;47279.527204727514;48102.27846582234;48125.27812082751;48262.75868620635;48634;52777.736111319195;52891.73554132205;53089.20366194433;53931.73034134961;54367;44330.77834610806;45217;45563;45743.313850292936;46563;43443.131137377706;44964;45312.77343613261;45453.318200226364;46272.07455850932;45073;45618.54381456143;46518.53481465142;47217.52782472269;48863;39866.80066599648;39973.60026399699;40174;40251.79874100728;40520.98697532585;30731;31050.031994880712;31333.52999705052;31356.216094597818;31528.36943261168 03:48:43 INFO - PROCESS | 3460 | |2;jquery.html;397.7176204894523;398.6969902873815;411.6747769262283;412.2970335577839;422.37910271900296;19215.903920480396;21004.054817533208;21444.89277553614;21454.678179827297;21597.67603485945;12005;12261.141720079575;16950.745738813926;20436;20771.584568308626;5341.0920143575495;5414.40441551429;5470.863228419302;5484.8354549363585;5540.085885828834;5315.627906046579;5319.840404787843;5369.221462887879;5382.461753824626;5415.431379705134;5373.75818088185;5445.1832225166345;6991.475639327071;7312.1956584775635;7323.48735588509;7336.633168341588;7451.32938035574;7473.588952607604;7493.700251989914;7494.925050749532;6934.16789985205;7229.566226026455;7288.526245794006;7292.963535182344;7295.088113985752;27429.17712468629;28144.718552814415;28234.2941426466;28794.71205287941;29020;2593.0535354595627;2799.0343331550584;2967.243352945007;3074;3506.736994725406;16441;16445.424410145708;16503.009819410872;17397.739033914502;17417.738733918875;2102.747670279561;2120.7031015657667;2181.7054697615777;2182.5416662500893;2209.0169874405897;80646.59676701638;99343;99689;100965;102684;18352.174152163185;19966.90016549908;20028.59942801136;20085.096170672354;20281.594368112554;35425.114372140386;35649.28701425957;35754.64245357565;35830.64169358273;36488.635113648525;10398;10501.474926253657;10540.945905409551;10651.201159913038;10960.397178155277;8470.110638382881;8582.65669373218;8621.956890215633;8665.090165532654;8826.646934122564;9450.810983780286;9587.328886977984;9616.12485565308;9729.659461918798;9913.008699130029;3476.3047390521997;3592.9281414371567;3737.289914916157;3742.7754334740002;3745.7190710696805;952.9714108576753;1012.448215722433;1044.4907109227245;1076.6070384309828;1083.943155423456;20657.793422065886;21320.680189796854;21411.143554257655;21477.57044859094;21515.784842151377;1044.9738756530996;1059.7933402986498;1081.5187241677536;1099.2140619456966;1106.1593189176124;11549.88450115505;11640.359780212;11746.647600571996;11955.701107472209;11971.52113915451;525069;567359;572287;574105;576363;63804.68097659482;65664;97037.51481242549;100356.49821750844;100679.49660251652;1034.3121823986965;1065.5258410007473;1091.2633972068822;1097.550004498152;1099.7745462180235;18736.718949216047;18788.718169227745;19106;19391.127399266785;19413.902930485256;32428.37858107038;36380.81809591041;45509;46304.768476157406;46490.07019859516;64898.35101649112;65346.48542762453;65680.34319656742;67002.3299766996;67068.32931670621;8562.48625082497;8872.600732966903;9037.77405564866;9096.590653420744;9196.724098277062;13177.802332964822;14170.645733856736;14391.78412323795;14653;14881.702365952404;12180.939095304468;12278.386080696107;12446.502139914664;12459.813102803284;12484.500619975099;10594.894051059391;12175.939120304341;12293.815592766294;12497.750044998867;12711.491540338282;10821.621243256448;12572.748545029232;12602.873971260537;12765.61703148907;12973.221606703628;7265.237150099163;7501.437392195498;8809.031006589143;9084.273258139201;9090.590923408594;11964.64106076819;11965.641030769091;12010.519579216734;12380.257184568954;12795.616131515697 03:48:43 INFO - PROCESS | 3460 | |3;mootools.html;1544.1044194367264;1568.4824008077335;1759.964800703986;1873.4379686094178;1877.6057028024113;8458.154184581539;8487.702930397438;9191.770205744851;9874.802503949917;9890.604375824967;8817.735467935956;8976.73069807905;9220.815583688322;9340;9357.25141988641;2392.210570511727;2439.560879041772;2456.6437866509345;2457.287386657876;2461.618449140386;2450.0812195426715;2451.852888826676;2494.6756921600168;2503.2114883811632;2507.6865391826022;2404.3989002749313;2449.3386785567886;2476.913308034219;2505.0480817289404;2507.962380564293;2369.917052903149;2385.5705972924866;2389.7849193572574;2450.767177118171;2454.1165180534995;2392.1268736911074;2396.6524853896262;2398.8080953523677;2399.5560821248123;2420.261820144855;9420.434773913586;9462.101100395521;9482.573284202228;9505;9521.28590355726;5592.552595792367;5701.429857014306;5736.827895163152;5744.080947048452;5752.683602401867;3467.845154435031;3576.141725985771;3634;3655.963440365589;3665.2669466106618;1178.3342411537453;1181.5155786127732;1214.7995580729169;1216.8722284160124;1256.7549327881068;13220.6694832629;13483.460661573525;13506;13519.324033798272;13522.864771352357;4804.519548045238;4857.101436234308;4879.291992943879;4953.7027778332695;5036.823711170092;11357.432128393548;11412.771744565061;11414.714632134263;11417.37204453763;11479.368634725004;5609;5652.152177173375;5678.829635110953;5695.288088988877;5700.287464066992;4546.568076032838;5053.494650534917;5136.255242989746;5155.432902380735;5157.303763991813;4220.641245494167;4230.873073807791;4386.605205531518;4396.252637051709;4421.889452763707;1345.327336331834;1369.7465968795805;1375.3329635126956;1379.6412932637386;1386.0851837787013;1039.1271332080937;1048.8374301983206;1050.3540322701635;1059.1579694143174;1071.7159952612565;6398.616083035033;6436.774712885027;6558.967205164039;6664.033715111379;6748.392644661906;490.7423602608659;492.6600645554627;1080.7244152741;1112.7440688641657;1151.867535233459;4320.870373888725;4426.092651006536;4540.79566419512;4582.335561343587;4607.884802879955;11352.886471135183;11405.543778248943;11792.823107653392;11818.704532386588;11877.643670689893;11503.539858405737;12118.333491658044;12145.635630931087;12187.695307617381;12199.69500762488;8879.24526415249;8894.59974301158;8899.866502002475;8937.061608531141;8960.775980600538;6397.552171347961;6569.146817493887;6572.704228309642;6575.80272591823;6605.438537724347;11113.555457781598;11159.21885468042;11175;11175.441227938409;11314.943425282821;10926.180536459957;11083.612073577386;11238.66284011481;11285.492152852978;11323.830142547704;7657.425693072931;8229.135940726137;8379.83240335202;8403.915960840557;8553.315734741082;9271.721848344561;9361.204297634777;9419.952900235456;9421.199198068241;9423;8187.099419063779;8201.384896132933;8226.383021273308;8330;8469.830603388022;7843.882341764764;7971.681132754625;8095.190480952093;8166.550839703873;8348.123447037973;7549.131849837339;7587.127480339611;7642.847143057219;7674.079110506775;7736.613169341623;5781.075027995501;5815.709214539341;5817.301923769175;5839.416058394127;5989.161517387656;5745.109508026263;5805.738741756547;5870.295564532113;5873.119032145212;5901.557383196192 03:48:43 INFO - PROCESS | 3460 | |4;prototype.html;326.90683155300746;327.2440662070617;333.14880480372636;333.6346700363102;336.02217546938414;5805.36141024487;5811.111388798641;5868.70656467176;5891.351951285366;5908.231929849119;5739.306904463183;5790.623609465381;5794.855128621786;5803.390643982384;5844.649321040741;4271.9359209611885;4368.912621747563;4414.911701765963;4465.990304363034;4478.776061196943;4426.313921342181;4429.60133587977;4435.556444355571;4469.955300447003;4470.910581788378;4410.338449232609;4422.181896349186;4439.533848945863;4454.554544545552;4500.347449619803;4349.869503914888;4447.177272204653;4456.465224173087;4460.643148548108;4465;3891.299566078105;3928.5268024490815;3933.9016524586827;3936.940945885814;3941.8620348287673;5618.410066942953;5677;5700.230468886689;5700.657960522382;5717.514011309044;5037.370328708911;5083.79664813407;5159.303494028296;5169.974150129226;5184.403793563713;5968.731407086691;6004.729787159588;6009.09863520471;6038.426349496791;6049.909251361233;4286.678499112579;4320.4383430153875;4343.67422443318;4357.564243575617;4363.563643635643;6143.539234557426;6183.608688045154;6271.27880293763;6275.811725648238;6346.841328966767;4436.179306828247;4438.203931523184;4440.933385999213;4446.510883802779;4449.28811390176;4327.978360108179;4493.348464472633;4496.775161241925;4499.820007199741;4501.48232953208;5093.414257360377;5104.948950510522;5116.411612664591;5124.359455068116;5134.409542902539;6045.304789949124;6099.146119543268;6119.724612392364;6123.9387606124255;6130.141780150782;1458.7593047147313;1531.1655147944398;1552.2781906413572;1555.7899683542803;1578.5974576482924;952.5856252530172;956.3114557518576;963.8650588917557;997.6957028106498;1030.5362586835954;5773.422657734193;5781.364049954502;5846.883062338729;5889.911651325234;5890.558208134407;6134.6625935573975;6152.753889844356;6160.784372547029;6182.907256391158;6211.534134939898;5700.572457065737;5752.884942301214;5775.5668324875805;5799.3620701722775;5825.155352473867;3309.791925947012;3330.7834990725523;3342.598888133391;3343.598768147789;3365.915852103717;6223.626582405071;6370.7190796739715;6397.713531933616;6474.935250647527;6481.449076828428;6304.360866174736;6330.651814150266;6354.396332348512;6356.904646430307;6366.172397588284;6308.621482711052;6385.744570217139;6410.326915673787;6423.389777971085;6440.54916155874;6122;6139.158252524136;6166.660833654192;6175.536834737323;6195.19462469876;6113.724882380215;6130.2030736004035;6139.969300153471;6156.661383623944;6168.660723660242;6167.629942203482;6360.427561519486;6400.967995159995;6436.452901503425;6457.6771161442675;4387.36383224437;4392.3411488277015;4396.758178300224;4402.031553058322;4402.471703395613;6053.788117415869;6230.43926046658;6245.687715614292;6303.212098487689;6329.841753956188;6111.84720381994;6138.723757431016;6141.815745527641;6173.290071641819;6191;6098.695065246809;6187.855246779361;6196.752129914753;6198.644515084239;6218.730163490384;5961.254843144607;6049.576529642883;6088.360722124113;6124.846878828065;6129.969350153399;6092.7814437111865;6151.123907208165;6166;6173.536984726254;6183.876322473436;5914.7338369774325;6014.368491308524;6037.305709843425;6046.1535385045245;6062.787802426894 03:48:43 INFO - PROCESS | 3460 | |5;yui.html;806.2743530822261;823.8558252305845;847.3905907014458;871.6252011634997;917.2570218123317;15562.922185389072;16680.082595457246;16717.498475045737;16724.49826505207;16739.748903766453;15143.848561514382;15552.611184720388;15675.686486270268;15711.371545138209;15904.76142857858;864.8270345930807;886.366248132585;900.5632268349877;902.8961669408004;905.6603773584906;894.8120894612139;901.3870568013748;905.3933864310927;906.3746015249457;910.2308549275851;943.2548286853378;947.90520947905;949.8907625623038;952.128802146039;953.2659851914023;935.7379933618598;948.1087777489138;948.8054948735527;950.9239260859115;951.4434056077204;691.4537515362857;695.6139342664819;696.7979286007052;696.853660731247;699.0143897105057;16589.419370321983;16706.331746730237;16710;16763.49709508717;16783.32866685331;16206.75689864653;16210.918945405316;16308.673826523522;16325.83674163267;16562.58593535159;13088.214707117604;13454.260015699132;13471.932640336736;13589.592312230649;13891.652708682263;4136.31750761124;4164.6251837334785;4175.164967006611;4268.231718290706;4276.828926842923;87456.56271718664;87578;87746.56126719389;88158;88495.55752221198;12145;12173.2696038238;12204.477299672271;12215.93892030552;12594.118411711275;23539.7646023541;23670;23798.76201238;23956;24779;8378.706745263886;8649.956750216208;8691.869621955675;8751.037385887546;8782.736517904474;5012.997400519837;5051.823186188466;5125.384953805567;5140.871478213075;5324.361076670824;3599.8200089995394;4027.0737730321603;4196.034911970264;4201.054762678373;4304.418903448057;697.8464737757686;721.1994685898649;726.2374506767873;733.8312188196745;739.3087463221905;754.9131849837229;771.9691212351443;784.2555506106953;802.4944285100349;822.1490757066407;10610.20423468243;11014;11179.591511089822;11197.776044479066;11203.327800332007;609.3358239518946;763.8930549723043;767.5202998126172;793.5318162284279;820;4995.225740010304;5090.643654944192;5161.122609156452;5170.9324861635805;5234.162533994619;120508.3974580139;129673;130003;137929.3103534496;140574;91747;100049.49975250078;102921;103908;104332.47833760783;58378.4162158373;76307.61846190733;88216;88634.55682721545;93874.53062734779;10301.587936482456;10487.685369438928;10745.946270268598;10922.344659320466;10999.34003959765;54192.45807541874;55517;55959;56094.71952640211;56332.718336408056;81037;81085.59457202676;81147.59426203067;83724.58137709272;84960;14133.929330353694;14323.14061156334;14349.497767578085;14372;14461.927690361481;15376.154311512526;15589.220538973233;15656.921715391805;15757.212139393214;15910.204489775233;13967;14519.128852268897;14937.477188298357;15232.923835380752;16226.756598651265;14873.18197499148;14979.700405992036;15906.9204653976;16059.357625694842;16352.509424717278;15153.166575838435;15370.769438458208;16056.759148612546;16449;16696.666066678354;12471.189372690746;12572.182808117443;12791.80812287835;12846.871531284942;13060.412281447168;12835.229886206858;13002.219866808022;13087.214767114003;13156.836760523793;13237.470501179845 03:48:43 INFO - PROCESS | 3460 | __end_tp_report 03:48:43 INFO - PROCESS | 3460 | __start_cc_report 03:48:43 INFO - PROCESS | 3460 | _x_x_mozilla_cycle_collect,324 03:48:43 INFO - PROCESS | 3460 | __end_cc_report 03:48:43 INFO - PROCESS | 3460 | __startTimestamp1471430923501__endTimestamp 03:48:43 INFO - PROCESS | 3460 | 03:48:43 INFO - PROCESS | 3460 | ------- Summary: start ------- 03:48:43 INFO - PROCESS | 3460 | Number of tests: 6 03:48:43 INFO - PROCESS | 3460 | 03:48:43 INFO - PROCESS | 3460 | [#0] dojo.html Cycles:165 Average:5678.84 Median:5897.88 stddev:636.93 (10.8%) stddev-sans-first:610.56 03:48:43 INFO - PROCESS | 3460 | Values: 3284.8 3349.4 3354.6 3366.5 3371.2 5651.4 5714.6 5723.6 5724.2 5739.3 5649.1 5780.7 5788.3 5803.9 5828.9 5078.3 5200.3 5222.3 5285.1 5296.4 5113.8 5150.5 5197.9 5216.6 5276.2 5208.1 5232.7 5243.8 5251.9 5292.2 5272.2 5281.1 5292.1 5293.9 5312.0 4968.8 5029.2 5049.1 5189.1 5214.3 5600.9 5628.3 5657.1 5664.5 5684.2 6021.5 6025.8 6061.8 6070.4 6082.5 5979.3 6060.5 6123.2 6127.1 6127.6 5756.1 5756.2 5771.9 5784.5 5801.7 6306.2 6333.9 6338.2 6342.1 6345.7 5786.4 5955.9 6001.8 6065.9 6083.3 6100.9 6136.2 6137.9 6143.2 6151.6 6088.1 6099.7 6101.9 6104.5 6107.4 5882.9 5980.8 6022.5 6046.4 6126.5 4671.3 4683.1 4686.8 4698.3 4708.0 4182.7 4186.5 4187.0 4193.7 4204.2 5636.7 5781.9 5789.0 5865.4 5882.8 6116.1 6118.4 6126.1 6137.1 6155.7 5828.7 5874.1 5897.2 5906.0 5909.9 5033.4 5159.4 5239.6 5240.3 5306.7 6321.2 6346.2 6349.9 6350.9 6391.1 6076.8 6083.3 6087.5 6093.6 6116.7 6100.2 6222.4 6253.8 6287.3 6335.2 5994.0 6029.0 6032.8 6041.8 6076.1 6126.2 6129.5 6133.3 6135.5 6167.0 5824.2 5938.3 5964.8 5990.0 6000.5 5972.2 5977.5 5988.5 6004.9 6025.6 5897.9 5965.9 5967.4 5978.3 5979.2 5792.9 5890.9 5893.6 5974.3 5976.5 5873.7 5878.7 5878.9 5905.3 5907.6 03:48:43 INFO - PROCESS | 3460 | 03:48:43 INFO - PROCESS | 3460 | [#1] ext.html Cycles:180 Average:66405.98 Median:43466.35 stddev:138906.90 (319.6%) stddev-sans-first:139208.65 03:48:43 INFO - PROCESS | 3460 | Values: 581.9 611.8 643.7 649.9 670.8 40440.0 44563.8 44676.8 44732.3 44755.3 45546.8 46349.8 46357.5 46439.8 46488.1 8986.1 9117.7 9188.7 9196.1 9198.5 9104.6 9139.6 9171.8 9210.8 9212.1 9233.6 9265.3 9266.5 9267.7 9274.9 9218.5 9229.8 9262.6 9265.6 9302.7 9051.4 9118.2 9129.1 9132.4 9137.6 42703.6 43340.0 43372.8 43381.8 43489.6 3111.0 3553.4 3784.6 3786.0 3828.1 33582.8 33887.7 34061.3 34106.0 34452.7 4061.7 4072.3 4100.6 4152.4 4161.2 332655.0 332760.0 334155.0 334603.3 335328.0 34237.3 39393.8 39506.2 39629.4 39790.8 40668.0 40764.0 40871.2 40875.0 40913.8 16856.5 16870.8 16911.1 16915.6 16938.0 13349.2 13572.9 13574.6 13591.1 13683.4 9185.1 9249.0 9257.5 9258.7 9339.0 3521.7 3547.7 3558.6 3562.2 3562.4 1099.3 1123.5 1123.8 1139.7 1227.3 34141.0 34705.1 34724.8 34732.7 34829.8 1175.0 1175.8 1192.8 1223.0 1261.2 17940.3 18010.6 18091.2 18212.2 18274.5 622759.0 624742.0 626645.0 628736.0 629140.0 64258.0 64352.0 65162.7 65242.0 65497.0 1424.3 1445.9 1450.9 1460.5 1466.7 31259.8 33365.7 33505.0 34123.8 34497.0 61602.0 62734.4 62856.7 69038.3 69542.0 552133.0 553495.0 553829.0 557727.0 563146.0 47279.5 48102.3 48125.3 48262.8 48634.0 52777.7 52891.7 53089.2 53931.7 54367.0 44330.8 45217.0 45563.0 45743.3 46563.0 43443.1 44964.0 45312.8 45453.3 46272.1 45073.0 45618.5 46518.5 47217.5 48863.0 39866.8 39973.6 40174.0 40251.8 40521.0 30731.0 31050.0 31333.5 31356.2 31528.4 03:48:43 INFO - PROCESS | 3460 | 03:48:43 INFO - PROCESS | 3460 | [#2] jquery.html Cycles:180 Average:33243.20 Median:15471.88 stddev:92547.91 (598.2%) stddev-sans-first:92774.67 03:48:43 INFO - PROCESS | 3460 | Values: 397.7 398.7 411.7 412.3 422.4 19215.9 21004.1 21444.9 21454.7 21597.7 12005.0 12261.1 16950.7 20436.0 20771.6 5341.1 5414.4 5470.9 5484.8 5540.1 5315.6 5319.8 5369.2 5382.5 5415.4 5373.8 5445.2 6991.5 7312.2 7323.5 7336.6 7451.3 7473.6 7493.7 7494.9 6934.2 7229.6 7288.5 7293.0 7295.1 27429.2 28144.7 28234.3 28794.7 29020.0 2593.1 2799.0 2967.2 3074.0 3506.7 16441.0 16445.4 16503.0 17397.7 17417.7 2102.7 2120.7 2181.7 2182.5 2209.0 80646.6 99343.0 99689.0 100965.0 102684.0 18352.2 19966.9 20028.6 20085.1 20281.6 35425.1 35649.3 35754.6 35830.6 36488.6 10398.0 10501.5 10540.9 10651.2 10960.4 8470.1 8582.7 8622.0 8665.1 8826.6 9450.8 9587.3 9616.1 9729.7 9913.0 3476.3 3592.9 3737.3 3742.8 3745.7 953.0 1012.4 1044.5 1076.6 1083.9 20657.8 21320.7 21411.1 21477.6 21515.8 1045.0 1059.8 1081.5 1099.2 1106.2 11549.9 11640.4 11746.6 11955.7 11971.5 525069.0 567359.0 572287.0 574105.0 576363.0 63804.7 65664.0 97037.5 100356.5 100679.5 1034.3 1065.5 1091.3 1097.6 1099.8 18736.7 18788.7 19106.0 19391.1 19413.9 32428.4 36380.8 45509.0 46304.8 46490.1 64898.4 65346.5 65680.3 67002.3 67068.3 8562.5 8872.6 9037.8 9096.6 9196.7 13177.8 14170.6 14391.8 14653.0 14881.7 12180.9 12278.4 12446.5 12459.8 12484.5 10594.9 12175.9 12293.8 12497.8 12711.5 10821.6 12572.7 12602.9 12765.6 12973.2 7265.2 7501.4 8809.0 9084.3 9090.6 11964.6 11965.6 12010.5 12380.3 12795.6 03:48:43 INFO - PROCESS | 3460 | 03:48:43 INFO - PROCESS | 3460 | [#3] mootools.html Cycles:180 Average:6283.04 Median:4543.68 stddev:3603.44 (79.3%) stddev-sans-first:3595.95 03:48:43 INFO - PROCESS | 3460 | Values: 1544.1 1568.5 1760.0 1873.4 1877.6 8458.2 8487.7 9191.8 9874.8 9890.6 8817.7 8976.7 9220.8 9340.0 9357.3 2392.2 2439.6 2456.6 2457.3 2461.6 2450.1 2451.9 2494.7 2503.2 2507.7 2404.4 2449.3 2476.9 2505.0 2508.0 2369.9 2385.6 2389.8 2450.8 2454.1 2392.1 2396.7 2398.8 2399.6 2420.3 9420.4 9462.1 9482.6 9505.0 9521.3 5592.6 5701.4 5736.8 5744.1 5752.7 3467.8 3576.1 3634.0 3656.0 3665.3 1178.3 1181.5 1214.8 1216.9 1256.8 13220.7 13483.5 13506.0 13519.3 13522.9 4804.5 4857.1 4879.3 4953.7 5036.8 11357.4 11412.8 11414.7 11417.4 11479.4 5609.0 5652.2 5678.8 5695.3 5700.3 4546.6 5053.5 5136.3 5155.4 5157.3 4220.6 4230.9 4386.6 4396.3 4421.9 1345.3 1369.7 1375.3 1379.6 1386.1 1039.1 1048.8 1050.4 1059.2 1071.7 6398.6 6436.8 6559.0 6664.0 6748.4 490.7 492.7 1080.7 1112.7 1151.9 4320.9 4426.1 4540.8 4582.3 4607.9 11352.9 11405.5 11792.8 11818.7 11877.6 11503.5 12118.3 12145.6 12187.7 12199.7 8879.2 8894.6 8899.9 8937.1 8960.8 6397.6 6569.1 6572.7 6575.8 6605.4 11113.6 11159.2 11175.0 11175.4 11314.9 10926.2 11083.6 11238.7 11285.5 11323.8 7657.4 8229.1 8379.8 8403.9 8553.3 9271.7 9361.2 9420.0 9421.2 9423.0 8187.1 8201.4 8226.4 8330.0 8469.8 7843.9 7971.7 8095.2 8166.6 8348.1 7549.1 7587.1 7642.8 7674.1 7736.6 5781.1 5815.7 5817.3 5839.4 5989.2 5745.1 5805.7 5870.3 5873.1 5901.6 03:48:43 INFO - PROCESS | 3460 | 03:48:43 INFO - PROCESS | 3460 | [#4] prototype.html Cycles:180 Average:5105.16 Median:5857.79 stddev:1518.03 (25.9%) stddev-sans-first:1479.32 03:48:43 INFO - PROCESS | 3460 | Values: 326.9 327.2 333.1 333.6 336.0 5805.4 5811.1 5868.7 5891.4 5908.2 5739.3 5790.6 5794.9 5803.4 5844.6 4271.9 4368.9 4414.9 4466.0 4478.8 4426.3 4429.6 4435.6 4470.0 4470.9 4410.3 4422.2 4439.5 4454.6 4500.3 4349.9 4447.2 4456.5 4460.6 4465.0 3891.3 3928.5 3933.9 3936.9 3941.9 5618.4 5677.0 5700.2 5700.7 5717.5 5037.4 5083.8 5159.3 5170.0 5184.4 5968.7 6004.7 6009.1 6038.4 6049.9 4286.7 4320.4 4343.7 4357.6 4363.6 6143.5 6183.6 6271.3 6275.8 6346.8 4436.2 4438.2 4440.9 4446.5 4449.3 4328.0 4493.3 4496.8 4499.8 4501.5 5093.4 5104.9 5116.4 5124.4 5134.4 6045.3 6099.1 6119.7 6123.9 6130.1 1458.8 1531.2 1552.3 1555.8 1578.6 952.6 956.3 963.9 997.7 1030.5 5773.4 5781.4 5846.9 5889.9 5890.6 6134.7 6152.8 6160.8 6182.9 6211.5 5700.6 5752.9 5775.6 5799.4 5825.2 3309.8 3330.8 3342.6 3343.6 3365.9 6223.6 6370.7 6397.7 6474.9 6481.4 6304.4 6330.7 6354.4 6356.9 6366.2 6308.6 6385.7 6410.3 6423.4 6440.5 6122.0 6139.2 6166.7 6175.5 6195.2 6113.7 6130.2 6140.0 6156.7 6168.7 6167.6 6360.4 6401.0 6436.5 6457.7 4387.4 4392.3 4396.8 4402.0 4402.5 6053.8 6230.4 6245.7 6303.2 6329.8 6111.8 6138.7 6141.8 6173.3 6191.0 6098.7 6187.9 6196.8 6198.6 6218.7 5961.3 6049.6 6088.4 6124.8 6130.0 6092.8 6151.1 6166.0 6173.5 6183.9 5914.7 6014.4 6037.3 6046.2 6062.8 03:48:43 INFO - PROCESS | 3460 | 03:48:43 INFO - PROCESS | 3460 | [#5] yui.html Cycles:180 Average:22580.86 Median:4081.70 stddev:32328.01 (792.0%) stddev-sans-first:32377.35 03:48:43 INFO - PROCESS | 3460 | Values: 806.3 823.9 847.4 871.6 917.3 15562.9 16680.1 16717.5 16724.5 16739.7 15143.8 15552.6 15675.7 15711.4 15904.8 864.8 886.4 900.6 902.9 905.7 894.8 901.4 905.4 906.4 910.2 943.3 947.9 949.9 952.1 953.3 935.7 948.1 948.8 950.9 951.4 691.5 695.6 696.8 696.9 699.0 16589.4 16706.3 16710.0 16763.5 16783.3 16206.8 16210.9 16308.7 16325.8 16562.6 13088.2 13454.3 13471.9 13589.6 13891.7 4136.3 4164.6 4175.2 4268.2 4276.8 87456.6 87578.0 87746.6 88158.0 88495.6 12145.0 12173.3 12204.5 12215.9 12594.1 23539.8 23670.0 23798.8 23956.0 24779.0 8378.7 8650.0 8691.9 8751.0 8782.7 5013.0 5051.8 5125.4 5140.9 5324.4 3599.8 4027.1 4196.0 4201.1 4304.4 697.8 721.2 726.2 733.8 739.3 754.9 772.0 784.3 802.5 822.1 10610.2 11014.0 11179.6 11197.8 11203.3 609.3 763.9 767.5 793.5 820.0 4995.2 5090.6 5161.1 5170.9 5234.2 120508.4 129673.0 130003.0 137929.3 140574.0 91747.0 100049.5 102921.0 103908.0 104332.5 58378.4 76307.6 88216.0 88634.6 93874.5 10301.6 10487.7 10745.9 10922.3 10999.3 54192.5 55517.0 55959.0 56094.7 56332.7 81037.0 81085.6 81147.6 83724.6 84960.0 14133.9 14323.1 14349.5 14372.0 14461.9 15376.2 15589.2 15656.9 15757.2 15910.2 13967.0 14519.1 14937.5 15232.9 16226.8 14873.2 14979.7 15906.9 16059.4 16352.5 15153.2 15370.8 16056.8 16449.0 16696.7 12471.2 12572.2 12791.8 12846.9 13060.4 12835.2 13002.2 13087.2 13156.8 13237.5 03:48:43 INFO - PROCESS | 3460 | -------- Summary: end -------- 03:48:43 INFO - PROCESS | 3460 | 03:48:44 INFO - TEST-INFO | 3460: exit 0 03:48:44 INFO - TEST-OK | dromaeo_css | took 1112657ms 03:48:44 INFO - TEST-START | kraken 03:48:44 INFO - operating with platform_type : linux_ 03:48:44 INFO - Initialising browser for kraken test... 03:48:44 INFO - TEST-INFO | started process 3724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKXmW1b/profile http://localhost:55304/getInfo.html) 03:48:48 INFO - PROCESS | 3724 | __metrics Screen width/height:1600/1200 03:48:48 INFO - PROCESS | 3724 | colorDepth:24 03:48:48 INFO - PROCESS | 3724 | Browser inner width/height: 1024/697 03:48:48 INFO - PROCESS | 3724 | __metrics 03:48:49 ERROR - PROCESS | 3724 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:48:50 INFO - TEST-INFO | 3724: exit 0 03:48:50 INFO - Browser initialized. 03:48:50 INFO - Running cycle 1/1 for kraken test... 03:48:50 INFO - TEST-INFO | started process 3850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKXmW1b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:01 INFO - PROCESS | 3850 | RSS: Main: 152936448 03:49:01 INFO - PROCESS | 3850 | 03:49:04 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55304/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:05 INFO - PROCESS | 3850 | RSS: Main: 157949952 03:49:05 INFO - PROCESS | 3850 | 03:49:07 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55304/tests/kraken/driver.html?testName=audio-dft) 03:49:08 INFO - PROCESS | 3850 | RSS: Main: 156504064 03:49:08 INFO - PROCESS | 3850 | 03:49:11 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55304/tests/kraken/driver.html?testName=audio-fft) 03:49:11 INFO - PROCESS | 3850 | RSS: Main: 157200384 03:49:11 INFO - PROCESS | 3850 | 03:49:13 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55304/tests/kraken/driver.html?testName=audio-oscillator) 03:49:14 INFO - PROCESS | 3850 | RSS: Main: 156876800 03:49:14 INFO - PROCESS | 3850 | 03:49:16 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:17 INFO - PROCESS | 3850 | RSS: Main: 157126656 03:49:17 INFO - PROCESS | 3850 | 03:49:20 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55304/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:21 INFO - PROCESS | 3850 | RSS: Main: 156786688 03:49:21 INFO - PROCESS | 3850 | 03:49:24 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55304/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:25 INFO - PROCESS | 3850 | RSS: Main: 154886144 03:49:25 INFO - PROCESS | 3850 | 03:49:28 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55304/tests/kraken/driver.html?testName=json-parse-financial) 03:49:28 INFO - PROCESS | 3850 | RSS: Main: 156774400 03:49:28 INFO - PROCESS | 3850 | 03:49:30 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:30 INFO - PROCESS | 3850 | RSS: Main: 156467200 03:49:30 INFO - PROCESS | 3850 | 03:49:32 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55304/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:33 INFO - PROCESS | 3850 | RSS: Main: 156446720 03:49:33 INFO - PROCESS | 3850 | 03:49:35 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:35 INFO - PROCESS | 3850 | RSS: Main: 156590080 03:49:35 INFO - PROCESS | 3850 | 03:49:38 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:39 INFO - PROCESS | 3850 | RSS: Main: 157290496 03:49:39 INFO - PROCESS | 3850 | 03:49:41 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:42 INFO - PROCESS | 3850 | RSS: Main: 157065216 03:49:42 INFO - PROCESS | 3850 | 03:49:43 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:55304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55304/tests/kraken/driver.html?testName=ai-astar) 03:49:44 INFO - PROCESS | 3850 | RSS: Main: 158437376 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | __start_tp_report 03:49:44 INFO - PROCESS | 3850 | _x_x_mozilla_page_load 03:49:44 INFO - PROCESS | 3850 | _x_x_mozilla_page_load_details 03:49:44 INFO - PROCESS | 3850 | |i|pagename|runs| 03:49:44 INFO - PROCESS | 3850 | |0;ai-astar;103;110;106;110;111;112;111;111;111;110 03:49:44 INFO - PROCESS | 3850 | |1;audio-beat-detection;142;117;137;164;120;141;144;120;172;118 03:49:44 INFO - PROCESS | 3850 | |2;audio-dft;162;162;163;162;161;162;161;161;162;161 03:49:44 INFO - PROCESS | 3850 | |3;audio-fft;75;76;75;169;76;76;76;75;190;77 03:49:44 INFO - PROCESS | 3850 | |4;audio-oscillator;84;82;153;85;85;84;149;84;85;143 03:49:44 INFO - PROCESS | 3850 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;118;118;119 03:49:44 INFO - PROCESS | 3850 | |6;imaging-darkroom;147;146;147;148;147;149;147;147;147;147 03:49:44 INFO - PROCESS | 3850 | |7;imaging-desaturate;95;95;97;95;95;95;95;96;95;95 03:49:44 INFO - PROCESS | 3850 | |8;json-parse-financial;52;57;53;51;54;55;54;52;53;53 03:49:44 INFO - PROCESS | 3850 | |9;json-stringify-tinderbox;60;60;60;61;60;59;60;59;61;61 03:49:44 INFO - PROCESS | 3850 | |10;stanford-crypto-aes;74;72;78;73;74;76;74;73;78;72 03:49:44 INFO - PROCESS | 3850 | |11;stanford-crypto-ccm;120;117;123;118;117;118;134;119;152;130 03:49:44 INFO - PROCESS | 3850 | |12;stanford-crypto-pbkdf2;159;153;159;156;155;152;152;154;153;156 03:49:44 INFO - PROCESS | 3850 | |13;stanford-crypto-sha256-iterative;63;61;62;64;65;64;60;62;62;60 03:49:44 INFO - PROCESS | 3850 | __end_tp_report 03:49:44 INFO - PROCESS | 3850 | __start_cc_report 03:49:44 INFO - PROCESS | 3850 | _x_x_mozilla_cycle_collect,857 03:49:44 INFO - PROCESS | 3850 | __end_cc_report 03:49:44 INFO - PROCESS | 3850 | __startTimestamp1471430984181__endTimestamp 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | ------- Summary: start ------- 03:49:44 INFO - PROCESS | 3850 | Number of tests: 14 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:2.80 (2.5%) stddev-sans-first:1.72 03:49:44 INFO - PROCESS | 3850 | Values: 103.0 110.0 106.0 110.0 111.0 112.0 111.0 111.0 111.0 110.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:141.50 stddev:19.38 (13.7%) stddev-sans-first:20.49 03:49:44 INFO - PROCESS | 3850 | Values: 142.0 117.0 137.0 164.0 120.0 141.0 144.0 120.0 172.0 118.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 03:49:44 INFO - PROCESS | 3850 | Values: 162.0 162.0 163.0 162.0 161.0 162.0 161.0 161.0 162.0 161.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#3] audio-fft Cycles:10 Average:96.50 Median:76.00 stddev:44.03 (57.9%) stddev-sans-first:46.01 03:49:44 INFO - PROCESS | 3850 | Values: 75.0 76.0 75.0 169.0 76.0 76.0 76.0 75.0 190.0 77.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:84.00 stddev:31.11 (37.0%) stddev-sans-first:32.20 03:49:44 INFO - PROCESS | 3850 | Values: 84.0 82.0 153.0 85.0 85.0 84.0 149.0 84.0 85.0 143.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 03:49:44 INFO - PROCESS | 3850 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 119.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:49:44 INFO - PROCESS | 3850 | Values: 147.0 146.0 147.0 148.0 147.0 149.0 147.0 147.0 147.0 147.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:49:44 INFO - PROCESS | 3850 | Values: 95.0 95.0 97.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:1.71 (3.2%) stddev-sans-first:1.74 03:49:44 INFO - PROCESS | 3850 | Values: 52.0 57.0 53.0 51.0 54.0 55.0 54.0 52.0 53.0 53.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 03:49:44 INFO - PROCESS | 3850 | Values: 60.0 60.0 60.0 61.0 60.0 59.0 60.0 59.0 61.0 61.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.00 stddev:2.22 (3.0%) stddev-sans-first:2.35 03:49:44 INFO - PROCESS | 3850 | Values: 74.0 72.0 78.0 73.0 74.0 76.0 74.0 73.0 78.0 72.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:121.50 stddev:11.18 (9.2%) stddev-sans-first:11.73 03:49:44 INFO - PROCESS | 3850 | Values: 120.0 117.0 123.0 118.0 117.0 118.0 134.0 119.0 152.0 130.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.50 stddev:2.60 (1.7%) stddev-sans-first:2.30 03:49:44 INFO - PROCESS | 3850 | Values: 159.0 153.0 159.0 156.0 155.0 152.0 152.0 154.0 153.0 156.0 03:49:44 INFO - PROCESS | 3850 | 03:49:44 INFO - PROCESS | 3850 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.70 (2.7%) stddev-sans-first:1.79 03:49:44 INFO - PROCESS | 3850 | Values: 63.0 61.0 62.0 64.0 65.0 64.0 60.0 62.0 62.0 60.0 03:49:44 INFO - PROCESS | 3850 | -------- Summary: end -------- 03:49:44 INFO - PROCESS | 3850 | 03:49:45 INFO - TEST-INFO | 3850: exit 0 03:49:45 INFO - TEST-OK | kraken | took 60970ms 03:49:45 INFO - SUITE-END | took 1173s 03:49:45 INFO - Completed test suite (00:19:33) 03:49:45 INFO - javascript benchmark 03:49:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7876.8644862619085, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3284.7536434767394, 3349.380364632543, 3354.580677415324, 3366.5455163552915, 3371.157210697326, 5651.350094739107, 5714.599978001542, 5723.570732195087, 5724.198612194296, 5739.253896993385, 5649.096144616862, 5780.653160810354, 5788.334341550712, 5803.854903627412, 5828.883422331562, 5078.289039534468, 5200.297959775429, 5222.3472065991755, 5285.075111855429, 5296.417394086648, 5113.769880355374, 5150.484951504838, 5197.948020519803, 5216.634835561512, 5276.182191760264, 5208.062548741244, 5232.686038837663, 5243.764030618612, 5251.894962100756, 5292.179712144623, 5272.23552584875, 5281.118377992173, 5292.126799078128, 5293.947060529384, 5311.973440132774, 4968.826091086795, 5029.245613158019, 5049.091163590552, 5189.091908915962, 5214.296070030536, 5600.887982240373, 5628.296462942132, 5657.066584013633, 5664.461876121762, 5684.175794509814, 6021.5182785377065, 6025.849353766147, 6061.848453788646, 6070.423309785563, 6082.513398928075, 5979.342272350038, 6060.515158787286, 6123.2039834821635, 6127.050307202391, 6127.632342059491, 5756.079027355603, 5756.165356023395, 5771.8557036074435, 5784.508316793078, 5801.680907550125, 6306.211723534559, 6333.873322533524, 6338.176037115146, 6342.112104305401, 6345.714442850082, 5786.392428795, 5955.910661339996, 6001.819945401645, 6065.939340606626, 6083.300420451616, 6100.908486372708, 6136.1821086261625, 6137.9286238596105, 6143.174139895698, 6151.569390142647, 6088.11722300264, 6099.69501524922, 6101.877962440815, 6104.511639068864, 6107.389261073946, 5882.941170588325, 5980.760769569169, 6022.45797878193, 6046.395360464006, 6126.479249263773, 4671.299305104194, 4683.086798074342, 4686.7656617169005, 4698.342232087442, 4707.976460117678, 4182.728122672017, 4186.518550366686, 4186.958130418657, 4193.727407718488, 4204.159168166379, 5636.689982050944, 5781.855453613609, 5788.971055144697, 5865.442782935615, 5882.794102206488, 6116.067872221748, 6118.4059889896, 6126.077532388462, 6137.070562331796, 6155.72299246535, 5828.6502809831545, 5874.148248503943, 5897.174395584621, 5906.0, 5909.940900591025, 5033.370828646419, 5159.355080614923, 5239.633225674166, 5240.318758561362, 5306.6550674206055, 6321.209848768904, 6346.17499725042, 6349.873002539924, 6350.904736428957, 6391.105245265667, 6076.817695469143, 6083.330833608388, 6087.4521293083835, 6093.634381937098, 6116.66358350295, 6100.23747031621, 6222.377762223741, 6253.78111766086, 6287.339829318039, 6335.208098987627, 5993.9700301498215, 6028.969855150696, 6032.849178770566, 6041.78853740117, 6076.088586712029, 6126.23422072241, 6129.509639228941, 6133.294671112701, 6135.509159267337, 6166.969165154145, 5824.184614154106, 5938.317093534299, 5964.761409543569, 5990.041593345044, 6000.459958603572, 5972.223610930551, 5977.5217982560425, 5988.461038506555, 6004.909926351021, 6025.578209525291, 5897.882042359214, 5965.880682386415, 5967.403259674172, 5978.3423823378525, 5979.222701048836, 5792.942070579409, 5890.9116363253725, 5893.5874488785375, 5974.2830860297045, 5976.462118409364, 5873.706314684334, 5878.676672783038, 5878.941210587839, 5905.261842269716, 5907.616004959664], "value": 5636.484424590149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.9243498345214, 611.8042226487523, 643.6781609195406, 649.8700259948012, 670.8222321084917, 40440.0, 44563.77718111405, 44676.77661611696, 44732.32901506476, 44755.328670069975, 45546.77226613862, 46349.768251158785, 46357.53642463574, 46439.76780116103, 46488.07023859521, 8986.056464071293, 9117.726468205965, 9188.724338269829, 9196.080391960817, 9198.494082825475, 9104.63581456741, 9139.634414623408, 9171.816563668723, 9210.815783684322, 9212.124848139416, 9233.58448869799, 9265.25877929764, 9266.490343031131, 9267.72196834096, 9274.907250927505, 9218.492982885939, 9229.815403691922, 9262.6294948202, 9265.629374825, 9302.674406395743, 9051.366404351633, 9118.179363857218, 9129.132732390412, 9132.406393584395, 9137.634494620273, 42703.57296427027, 43340.0, 43372.783136084436, 43381.78309108434, 43489.56510434887, 3110.9533356999664, 3553.4136867416846, 3784.564775050877, 3786.0345611869075, 3828.062124779419, 33582.83208583966, 33887.66112338894, 34061.318773624385, 34106.0, 34452.65547344519, 4061.695372847019, 4072.2873497137884, 4100.5899410058755, 4152.356384760367, 4161.2301724181125, 332655.0, 332760.0, 334155.0, 334603.326983366, 335328.0, 34237.31525369479, 39393.80303098523, 39506.209875802895, 39629.40555891664, 39790.80104599459, 40668.0, 40764.0, 40871.18257634831, 40875.0, 40913.79543102325, 16856.494305170865, 16870.831291687173, 16911.069891156105, 16915.57711057209, 16938.0, 13349.199048057148, 13572.864271357357, 13574.59276221715, 13591.116577422634, 13683.384247708877, 9185.081491850762, 9249.0, 9257.537123143951, 9258.67594634198, 9338.953305233566, 3521.7182625389905, 3547.6629720177057, 3558.5551806024246, 3562.2163124112653, 3562.4300111981956, 1099.263493459384, 1123.533843214137, 1123.775244951013, 1139.6694958461953, 1227.2881728597392, 34141.0, 34705.091219983144, 34724.82941509484, 34732.65267347294, 34829.825850870584, 1174.9588764393204, 1175.782480241158, 1192.80915053591, 1222.9694257643453, 1261.1613277170761, 17940.282388704305, 18010.63978720418, 18091.185896634684, 18212.180451879696, 18274.54313642143, 622759.0, 624742.0, 626645.0, 628736.0, 629140.0, 64258.0, 64352.0, 65162.67418662876, 65242.0, 65497.01754473687, 1424.309210033133, 1445.9204743739194, 1450.9492167774076, 1460.5326295585523, 1466.6993266380366, 31259.84370078135, 33365.666343336256, 33505.0, 34123.829380852934, 34497.0, 61602.0, 62734.37265627468, 62856.68571657295, 69038.30961690319, 69542.0, 552133.0, 553495.0, 553829.0, 557727.0, 563146.0, 47279.527204727514, 48102.27846582234, 48125.27812082751, 48262.75868620635, 48634.0, 52777.736111319195, 52891.73554132205, 53089.20366194433, 53931.73034134961, 54367.0, 44330.77834610806, 45217.0, 45563.0, 45743.313850292936, 46563.0, 43443.131137377706, 44964.0, 45312.77343613261, 45453.318200226364, 46272.07455850932, 45073.0, 45618.54381456143, 46518.53481465142, 47217.52782472269, 48863.0, 39866.80066599648, 39973.60026399699, 40174.0, 40251.79874100728, 40520.98697532585, 30731.0, 31050.031994880712, 31333.52999705052, 31356.216094597818, 31528.36943261168], "value": 20389.24557850842, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.7176204894523, 398.6969902873815, 411.6747769262283, 412.2970335577839, 422.37910271900296, 19215.903920480396, 21004.054817533208, 21444.89277553614, 21454.678179827297, 21597.67603485945, 12005.0, 12261.141720079575, 16950.745738813926, 20436.0, 20771.584568308626, 5341.0920143575495, 5414.40441551429, 5470.863228419302, 5484.8354549363585, 5540.085885828834, 5315.627906046579, 5319.840404787843, 5369.221462887879, 5382.461753824626, 5415.431379705134, 5373.75818088185, 5445.1832225166345, 6991.475639327071, 7312.1956584775635, 7323.48735588509, 7336.633168341588, 7451.32938035574, 7473.588952607604, 7493.700251989914, 7494.925050749532, 6934.16789985205, 7229.566226026455, 7288.526245794006, 7292.963535182344, 7295.088113985752, 27429.17712468629, 28144.718552814415, 28234.2941426466, 28794.71205287941, 29020.0, 2593.0535354595627, 2799.0343331550584, 2967.243352945007, 3074.0, 3506.736994725406, 16441.0, 16445.424410145708, 16503.009819410872, 17397.739033914502, 17417.738733918875, 2102.747670279561, 2120.7031015657667, 2181.7054697615777, 2182.5416662500893, 2209.0169874405897, 80646.59676701638, 99343.0, 99689.0, 100965.0, 102684.0, 18352.174152163185, 19966.90016549908, 20028.59942801136, 20085.096170672354, 20281.594368112554, 35425.114372140386, 35649.28701425957, 35754.64245357565, 35830.64169358273, 36488.635113648525, 10398.0, 10501.474926253657, 10540.945905409551, 10651.201159913038, 10960.397178155277, 8470.110638382881, 8582.65669373218, 8621.956890215633, 8665.090165532654, 8826.646934122564, 9450.810983780286, 9587.328886977984, 9616.12485565308, 9729.659461918798, 9913.008699130029, 3476.3047390521997, 3592.9281414371567, 3737.289914916157, 3742.7754334740002, 3745.7190710696805, 952.9714108576753, 1012.448215722433, 1044.4907109227245, 1076.6070384309828, 1083.943155423456, 20657.793422065886, 21320.680189796854, 21411.143554257655, 21477.57044859094, 21515.784842151377, 1044.9738756530996, 1059.7933402986498, 1081.5187241677536, 1099.2140619456966, 1106.1593189176124, 11549.88450115505, 11640.359780212, 11746.647600571996, 11955.701107472209, 11971.52113915451, 525069.0, 567359.0, 572287.0, 574105.0, 576363.0, 63804.68097659482, 65664.0, 97037.51481242549, 100356.49821750844, 100679.49660251652, 1034.3121823986965, 1065.5258410007473, 1091.2633972068822, 1097.550004498152, 1099.7745462180235, 18736.718949216047, 18788.718169227745, 19106.0, 19391.127399266785, 19413.902930485256, 32428.37858107038, 36380.81809591041, 45509.0, 46304.768476157406, 46490.07019859516, 64898.35101649112, 65346.48542762453, 65680.34319656742, 67002.3299766996, 67068.32931670621, 8562.48625082497, 8872.600732966903, 9037.77405564866, 9096.590653420744, 9196.724098277062, 13177.802332964822, 14170.645733856736, 14391.78412323795, 14653.0, 14881.702365952404, 12180.939095304468, 12278.386080696107, 12446.502139914664, 12459.813102803284, 12484.500619975099, 10594.894051059391, 12175.939120304341, 12293.815592766294, 12497.750044998867, 12711.491540338282, 10821.621243256448, 12572.748545029232, 12602.873971260537, 12765.61703148907, 12973.221606703628, 7265.237150099163, 7501.437392195498, 8809.031006589143, 9084.273258139201, 9090.590923408594, 11964.64106076819, 11965.641030769091, 12010.519579216734, 12380.257184568954, 12795.616131515697], "value": 10833.329242945843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.1044194367264, 1568.4824008077335, 1759.964800703986, 1873.4379686094178, 1877.6057028024113, 8458.154184581539, 8487.702930397438, 9191.770205744851, 9874.802503949917, 9890.604375824967, 8817.735467935956, 8976.73069807905, 9220.815583688322, 9340.0, 9357.25141988641, 2392.210570511727, 2439.560879041772, 2456.6437866509345, 2457.287386657876, 2461.618449140386, 2450.0812195426715, 2451.852888826676, 2494.6756921600168, 2503.2114883811632, 2507.6865391826022, 2404.3989002749313, 2449.3386785567886, 2476.913308034219, 2505.0480817289404, 2507.962380564293, 2369.917052903149, 2385.5705972924866, 2389.7849193572574, 2450.767177118171, 2454.1165180534995, 2392.1268736911074, 2396.6524853896262, 2398.8080953523677, 2399.5560821248123, 2420.261820144855, 9420.434773913586, 9462.101100395521, 9482.573284202228, 9505.0, 9521.28590355726, 5592.552595792367, 5701.429857014306, 5736.827895163152, 5744.080947048452, 5752.683602401867, 3467.845154435031, 3576.141725985771, 3634.0, 3655.963440365589, 3665.2669466106618, 1178.3342411537453, 1181.5155786127732, 1214.7995580729169, 1216.8722284160124, 1256.7549327881068, 13220.6694832629, 13483.460661573525, 13506.0, 13519.324033798272, 13522.864771352357, 4804.519548045238, 4857.101436234308, 4879.291992943879, 4953.7027778332695, 5036.823711170092, 11357.432128393548, 11412.771744565061, 11414.714632134263, 11417.37204453763, 11479.368634725004, 5609.0, 5652.152177173375, 5678.829635110953, 5695.288088988877, 5700.287464066992, 4546.568076032838, 5053.494650534917, 5136.255242989746, 5155.432902380735, 5157.303763991813, 4220.641245494167, 4230.873073807791, 4386.605205531518, 4396.252637051709, 4421.889452763707, 1345.327336331834, 1369.7465968795805, 1375.3329635126956, 1379.6412932637386, 1386.0851837787013, 1039.1271332080937, 1048.8374301983206, 1050.3540322701635, 1059.1579694143174, 1071.7159952612565, 6398.616083035033, 6436.774712885027, 6558.967205164039, 6664.033715111379, 6748.392644661906, 490.7423602608659, 492.6600645554627, 1080.7244152741, 1112.7440688641657, 1151.867535233459, 4320.870373888725, 4426.092651006536, 4540.79566419512, 4582.335561343587, 4607.884802879955, 11352.886471135183, 11405.543778248943, 11792.823107653392, 11818.704532386588, 11877.643670689893, 11503.539858405737, 12118.333491658044, 12145.635630931087, 12187.695307617381, 12199.69500762488, 8879.24526415249, 8894.59974301158, 8899.866502002475, 8937.061608531141, 8960.775980600538, 6397.552171347961, 6569.146817493887, 6572.704228309642, 6575.80272591823, 6605.438537724347, 11113.555457781598, 11159.21885468042, 11175.0, 11175.441227938409, 11314.943425282821, 10926.180536459957, 11083.612073577386, 11238.66284011481, 11285.492152852978, 11323.830142547704, 7657.425693072931, 8229.135940726137, 8379.83240335202, 8403.915960840557, 8553.315734741082, 9271.721848344561, 9361.204297634777, 9419.952900235456, 9421.199198068241, 9423.0, 8187.099419063779, 8201.384896132933, 8226.383021273308, 8330.0, 8469.830603388022, 7843.882341764764, 7971.681132754625, 8095.190480952093, 8166.550839703873, 8348.123447037973, 7549.131849837339, 7587.127480339611, 7642.847143057219, 7674.079110506775, 7736.613169341623, 5781.075027995501, 5815.709214539341, 5817.301923769175, 5839.416058394127, 5989.161517387656, 5745.109508026263, 5805.738741756547, 5870.295564532113, 5873.119032145212, 5901.557383196192], "value": 4994.281974972371, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.90683155300746, 327.2440662070617, 333.14880480372636, 333.6346700363102, 336.02217546938414, 5805.36141024487, 5811.111388798641, 5868.70656467176, 5891.351951285366, 5908.231929849119, 5739.306904463183, 5790.623609465381, 5794.855128621786, 5803.390643982384, 5844.649321040741, 4271.9359209611885, 4368.912621747563, 4414.911701765963, 4465.990304363034, 4478.776061196943, 4426.313921342181, 4429.60133587977, 4435.556444355571, 4469.955300447003, 4470.910581788378, 4410.338449232609, 4422.181896349186, 4439.533848945863, 4454.554544545552, 4500.347449619803, 4349.869503914888, 4447.177272204653, 4456.465224173087, 4460.643148548108, 4465.0, 3891.299566078105, 3928.5268024490815, 3933.9016524586827, 3936.940945885814, 3941.8620348287673, 5618.410066942953, 5677.0, 5700.230468886689, 5700.657960522382, 5717.514011309044, 5037.370328708911, 5083.79664813407, 5159.303494028296, 5169.974150129226, 5184.403793563713, 5968.731407086691, 6004.729787159588, 6009.09863520471, 6038.426349496791, 6049.909251361233, 4286.678499112579, 4320.4383430153875, 4343.67422443318, 4357.564243575617, 4363.563643635643, 6143.539234557426, 6183.608688045154, 6271.27880293763, 6275.811725648238, 6346.841328966767, 4436.179306828247, 4438.203931523184, 4440.933385999213, 4446.510883802779, 4449.28811390176, 4327.978360108179, 4493.348464472633, 4496.775161241925, 4499.820007199741, 4501.48232953208, 5093.414257360377, 5104.948950510522, 5116.411612664591, 5124.359455068116, 5134.409542902539, 6045.304789949124, 6099.146119543268, 6119.724612392364, 6123.9387606124255, 6130.141780150782, 1458.7593047147313, 1531.1655147944398, 1552.2781906413572, 1555.7899683542803, 1578.5974576482924, 952.5856252530172, 956.3114557518576, 963.8650588917557, 997.6957028106498, 1030.5362586835954, 5773.422657734193, 5781.364049954502, 5846.883062338729, 5889.911651325234, 5890.558208134407, 6134.6625935573975, 6152.753889844356, 6160.784372547029, 6182.907256391158, 6211.534134939898, 5700.572457065737, 5752.884942301214, 5775.5668324875805, 5799.3620701722775, 5825.155352473867, 3309.791925947012, 3330.7834990725523, 3342.598888133391, 3343.598768147789, 3365.915852103717, 6223.626582405071, 6370.7190796739715, 6397.713531933616, 6474.935250647527, 6481.449076828428, 6304.360866174736, 6330.651814150266, 6354.396332348512, 6356.904646430307, 6366.172397588284, 6308.621482711052, 6385.744570217139, 6410.326915673787, 6423.389777971085, 6440.54916155874, 6122.0, 6139.158252524136, 6166.660833654192, 6175.536834737323, 6195.19462469876, 6113.724882380215, 6130.2030736004035, 6139.969300153471, 6156.661383623944, 6168.660723660242, 6167.629942203482, 6360.427561519486, 6400.967995159995, 6436.452901503425, 6457.6771161442675, 4387.36383224437, 4392.3411488277015, 4396.758178300224, 4402.031553058322, 4402.471703395613, 6053.788117415869, 6230.43926046658, 6245.687715614292, 6303.212098487689, 6329.841753956188, 6111.84720381994, 6138.723757431016, 6141.815745527641, 6173.290071641819, 6191.0, 6098.695065246809, 6187.855246779361, 6196.752129914753, 6198.644515084239, 6218.730163490384, 5961.254843144607, 6049.576529642883, 6088.360722124113, 6124.846878828065, 6129.969350153399, 6092.7814437111865, 6151.123907208165, 6166.0, 6173.536984726254, 6183.876322473436, 5914.7338369774325, 6014.368491308524, 6037.305709843425, 6046.1535385045245, 6062.787802426894], "value": 4607.141311532485, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.2743530822261, 823.8558252305845, 847.3905907014458, 871.6252011634997, 917.2570218123317, 15562.922185389072, 16680.082595457246, 16717.498475045737, 16724.49826505207, 16739.748903766453, 15143.848561514382, 15552.611184720388, 15675.686486270268, 15711.371545138209, 15904.76142857858, 864.8270345930807, 886.366248132585, 900.5632268349877, 902.8961669408004, 905.6603773584906, 894.8120894612139, 901.3870568013748, 905.3933864310927, 906.3746015249457, 910.2308549275851, 943.2548286853378, 947.90520947905, 949.8907625623038, 952.128802146039, 953.2659851914023, 935.7379933618598, 948.1087777489138, 948.8054948735527, 950.9239260859115, 951.4434056077204, 691.4537515362857, 695.6139342664819, 696.7979286007052, 696.853660731247, 699.0143897105057, 16589.419370321983, 16706.331746730237, 16710.0, 16763.49709508717, 16783.32866685331, 16206.75689864653, 16210.918945405316, 16308.673826523522, 16325.83674163267, 16562.58593535159, 13088.214707117604, 13454.260015699132, 13471.932640336736, 13589.592312230649, 13891.652708682263, 4136.31750761124, 4164.6251837334785, 4175.164967006611, 4268.231718290706, 4276.828926842923, 87456.56271718664, 87578.0, 87746.56126719389, 88158.0, 88495.55752221198, 12145.0, 12173.2696038238, 12204.477299672271, 12215.93892030552, 12594.118411711275, 23539.7646023541, 23670.0, 23798.76201238, 23956.0, 24779.0, 8378.706745263886, 8649.956750216208, 8691.869621955675, 8751.037385887546, 8782.736517904474, 5012.997400519837, 5051.823186188466, 5125.384953805567, 5140.871478213075, 5324.361076670824, 3599.8200089995394, 4027.0737730321603, 4196.034911970264, 4201.054762678373, 4304.418903448057, 697.8464737757686, 721.1994685898649, 726.2374506767873, 733.8312188196745, 739.3087463221905, 754.9131849837229, 771.9691212351443, 784.2555506106953, 802.4944285100349, 822.1490757066407, 10610.20423468243, 11014.0, 11179.591511089822, 11197.776044479066, 11203.327800332007, 609.3358239518946, 763.8930549723043, 767.5202998126172, 793.5318162284279, 820.0, 4995.225740010304, 5090.643654944192, 5161.122609156452, 5170.9324861635805, 5234.162533994619, 120508.3974580139, 129673.0, 130003.0, 137929.3103534496, 140574.0, 91747.0, 100049.49975250078, 102921.0, 103908.0, 104332.47833760783, 58378.4162158373, 76307.61846190733, 88216.0, 88634.55682721545, 93874.53062734779, 10301.587936482456, 10487.685369438928, 10745.946270268598, 10922.344659320466, 10999.34003959765, 54192.45807541874, 55517.0, 55959.0, 56094.71952640211, 56332.718336408056, 81037.0, 81085.59457202676, 81147.59426203067, 83724.58137709272, 84960.0, 14133.929330353694, 14323.14061156334, 14349.497767578085, 14372.0, 14461.927690361481, 15376.154311512526, 15589.220538973233, 15656.921715391805, 15757.212139393214, 15910.204489775233, 13967.0, 14519.128852268897, 14937.477188298357, 15232.923835380752, 16226.756598651265, 14873.18197499148, 14979.700405992036, 15906.9204653976, 16059.357625694842, 16352.509424717278, 15153.166575838435, 15370.769438458208, 16056.759148612546, 16449.0, 16696.666066678354, 12471.189372690746, 12572.182808117443, 12791.80812287835, 12846.871531284942, 13060.412281447168, 12835.229886206858, 13002.219866808022, 13087.214767114003, 13156.836760523793, 13237.470501179845], "value": 8336.875340466013, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 106.0, 110.0, 111.0, 112.0, 111.0, 111.0, 111.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 137.0, 164.0, 120.0, 141.0, 144.0, 120.0, 172.0, 118.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 169.0, 76.0, 76.0, 76.0, 75.0, 190.0, 77.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 153.0, 85.0, 85.0, 84.0, 149.0, 84.0, 85.0, 143.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 57.0, 53.0, 51.0, 54.0, 55.0, 54.0, 52.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 60.0, 59.0, 60.0, 59.0, 61.0, 61.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 78.0, 73.0, 74.0, 76.0, 74.0, 73.0, 78.0, 72.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 123.0, 118.0, 117.0, 118.0, 134.0, 119.0, 152.0, 130.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 153.0, 159.0, 156.0, 155.0, 152.0, 152.0, 154.0, 153.0, 156.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 64.0, 65.0, 64.0, 60.0, 62.0, 62.0, 60.0], "value": 62.3, "unit": "score"}]}]} 03:49:45 INFO - Return code: 0 03:49:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:45 ERROR - # TBPL SUCCESS # 03:49:45 INFO - Running post-action listener: _resource_record_post_action 03:49:45 INFO - [mozharness: 2016-08-17 10:49:45.464553Z] Finished run-tests step (success) 03:49:45 INFO - Running post-run listener: _resource_record_post_run 03:49:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 7909376; Write bytes: 455626752; Read time: 1584; Write time: 338916 03:49:45 INFO - TinderboxPrint: CPU usage
13.2% 03:49:45 INFO - TinderboxPrint: I/O read bytes / time
7,909,376 / 1,584 03:49:45 INFO - TinderboxPrint: I/O write bytes / time
455,626,752 / 338,916 03:49:45 INFO - TinderboxPrint: CPU idle
8,238.2 (86.8%) 03:49:45 INFO - TinderboxPrint: CPU user
1,197.1 (12.6%) 03:49:45 INFO - TinderboxPrint: Swap in / out
0 / 0 03:49:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 79302656; Read time: 0; Write time: 79524 03:49:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 5668864; Write bytes: 376324096; Read time: 1384; Write time: 259392 03:49:46 INFO - Running post-run listener: _upload_blobber_files 03:49:46 INFO - Blob upload gear active. 03:49:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:49:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:49:46 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:47 INFO - (blobuploader) - INFO - Done attempting. 03:49:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:50 INFO - (blobuploader) - INFO - Done attempting. 03:49:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:51 INFO - (blobuploader) - INFO - Done attempting. 03:49:51 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:51 INFO - Return code: 0 03:49:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b5cc5a6c2a758d4c76ebd2b444709b493fd167a01cf1f57f4066c812c07a3256ed971304e51d0cd8505037346df7530abc14d2edcba9e0062bf99b0ed0df516", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3e8df22b6efd3b73594a516a4828ca27edb9bf4ebdf13a336d3b3ff01fc62c9f7f322c63e4a6e3fb109022912b52fa2bdfa5675184af9c7de511b40e9e73a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7916a4a9e879451ba0b034a38992065debe43bcd03a8b3d704c0cc82f3a299031fd7ecaffe3691d6d6a879913f4c2c00fdd85e3ed04e604df6275fbff4f2a98f"} 03:49:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:51 INFO - Contents: 03:49:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b5cc5a6c2a758d4c76ebd2b444709b493fd167a01cf1f57f4066c812c07a3256ed971304e51d0cd8505037346df7530abc14d2edcba9e0062bf99b0ed0df516", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3e8df22b6efd3b73594a516a4828ca27edb9bf4ebdf13a336d3b3ff01fc62c9f7f322c63e4a6e3fb109022912b52fa2bdfa5675184af9c7de511b40e9e73a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7916a4a9e879451ba0b034a38992065debe43bcd03a8b3d704c0cc82f3a299031fd7ecaffe3691d6d6a879913f4c2c00fdd85e3ed04e604df6275fbff4f2a98f"} 03:49:51 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:51 INFO - Copying logs to upload dir... 03:49:51 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1679.568610 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-08-17 03:49:51.540429) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 03:49:51.543521) ========= 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=337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499 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/7b5cc5a6c2a758d4c76ebd2b444709b493fd167a01cf1f57f4066c812c07a3256ed971304e51d0cd8505037346df7530abc14d2edcba9e0062bf99b0ed0df516", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3e8df22b6efd3b73594a516a4828ca27edb9bf4ebdf13a336d3b3ff01fc62c9f7f322c63e4a6e3fb109022912b52fa2bdfa5675184af9c7de511b40e9e73a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7916a4a9e879451ba0b034a38992065debe43bcd03a8b3d704c0cc82f3a299031fd7ecaffe3691d6d6a879913f4c2c00fdd85e3ed04e604df6275fbff4f2a98f"} build_url:https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011136 build_url: 'https://queue.taskcluster.net/v1/task/RK4fimQRSvqlcpXYXY1lTQ/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/7b5cc5a6c2a758d4c76ebd2b444709b493fd167a01cf1f57f4066c812c07a3256ed971304e51d0cd8505037346df7530abc14d2edcba9e0062bf99b0ed0df516", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3e8df22b6efd3b73594a516a4828ca27edb9bf4ebdf13a336d3b3ff01fc62c9f7f322c63e4a6e3fb109022912b52fa2bdfa5675184af9c7de511b40e9e73a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7916a4a9e879451ba0b034a38992065debe43bcd03a8b3d704c0cc82f3a299031fd7ecaffe3691d6d6a879913f4c2c00fdd85e3ed04e604df6275fbff4f2a98f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 03:49:51.567756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:49:51.568043) ========= 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=337fe3f4b1febe37b85fccc40000019e-1471429286.959146-947525499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004373 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:49:51.653515) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 03:49:51.653785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 03:49:51.654046) ========= ========= Total master_lag: 0.15 =========