builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1466018545.6 results: success (0) buildid: 20160615093425 builduid: 6d6cb93510eb4f8682bd2f73fc4118a1 revision: 3dda03d4037e84f6a646ceb934e4e5e3afd7ec29 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:25.597172) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:25.597594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:25.597864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:25.629011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:25.629278) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 12:22:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-15 12:22:26 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:25.727335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:25.727627) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020141 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:25.784957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:25.785284) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3dda03d4037e84f6a646ceb934e4e5e3afd7ec29 --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-beta --rev 3dda03d4037e84f6a646ceb934e4e5e3afd7ec29 --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=516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 12:22:26,132 truncating revision to first 12 chars 2016-06-15 12:22:26,132 Setting DEBUG logging. 2016-06-15 12:22:26,132 attempt 1/10 2016-06-15 12:22:26,132 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3dda03d4037e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 12:22:26,443 unpacking tar archive at: mozilla-beta-3dda03d4037e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625443 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:26.424637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:26.424907) ========= script_repo_revision: 3dda03d4037e84f6a646ceb934e4e5e3afd7ec29 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:26.425259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:26.425531) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 12:22:26.433868) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-15 12:22:26.434130) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:22:26 INFO - MultiFileLogger online at 20160615 12:22:26 in /builds/slave/test 12:22:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:22:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:22:26 INFO - {'append_to_log': False, 12:22:26 INFO - 'base_work_dir': '/builds/slave/test', 12:22:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:22:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:22:26 INFO - 'branch': 'Mozilla-Beta', 12:22:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:22:26 INFO - 'config_files': ('talos/linux_config.py',), 12:22:26 INFO - 'default_actions': ('clobber', 12:22:26 INFO - 'read-buildbot-config', 12:22:26 INFO - 'download-and-extract', 12:22:26 INFO - 'populate-webroot', 12:22:26 INFO - 'create-virtualenv', 12:22:26 INFO - 'install', 12:22:26 INFO - 'run-tests'), 12:22:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:22:26 INFO - 'download_minidump_stackwalk': True, 12:22:26 INFO - 'download_symbols': 'ondemand', 12:22:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:22:26 INFO - 'tooltool.py': '/tools/tooltool.py', 12:22:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:22:26 INFO - '/tools/misc-python/virtualenv.py')}, 12:22:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:22:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:22:26 INFO - 'installer_path': 'installer.exe', 12:22:26 INFO - 'log_level': 'info', 12:22:26 INFO - 'log_name': 'talos', 12:22:26 INFO - 'log_to_console': True, 12:22:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:22:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:22:26 INFO - 'opt_config_files': (), 12:22:26 INFO - 'pip_index': False, 12:22:26 INFO - 'sps_profile': False, 12:22:26 INFO - 'sps_profile_interval': 0, 12:22:26 INFO - 'suite': 'dromaeojs', 12:22:26 INFO - 'system_bits': '32', 12:22:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:22:26 INFO - 'title': 'talos-linux64-ix-061', 12:22:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:22:26 INFO - 'use_talos_json': True, 12:22:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:22:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:22:26 INFO - 'work_dir': 'build'} 12:22:26 INFO - ##### 12:22:26 INFO - ##### Running clobber step. 12:22:26 INFO - ##### 12:22:26 INFO - Running pre-action listener: _resource_record_pre_action 12:22:26 INFO - Running main action method: clobber 12:22:26 INFO - rmtree: /builds/slave/test/build 12:22:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:22:27 INFO - Running post-action listener: _resource_record_post_action 12:22:27 INFO - ##### 12:22:27 INFO - ##### Running read-buildbot-config step. 12:22:27 INFO - ##### 12:22:27 INFO - Running pre-action listener: _resource_record_pre_action 12:22:27 INFO - Running main action method: read_buildbot_config 12:22:27 INFO - Using buildbot properties: 12:22:27 INFO - { 12:22:27 INFO - "project": "", 12:22:27 INFO - "product": "firefox", 12:22:27 INFO - "script_repo_revision": "production", 12:22:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:22:27 INFO - "repository": "", 12:22:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:22:27 INFO - "buildid": "20160615093425", 12:22:27 INFO - "pgo_build": "True", 12:22:27 INFO - "basedir": "/builds/slave/test", 12:22:27 INFO - "buildnumber": 42, 12:22:27 INFO - "slavename": "talos-linux64-ix-061", 12:22:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:22:27 INFO - "platform": "ubuntu64_hw", 12:22:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:22:27 INFO - "branch": "mozilla-beta", 12:22:27 INFO - "repo_path": "releases/mozilla-beta", 12:22:27 INFO - "revision": "3dda03d4037e84f6a646ceb934e4e5e3afd7ec29", 12:22:27 INFO - "stage_platform": "linux64-pgo", 12:22:27 INFO - "builduid": "6d6cb93510eb4f8682bd2f73fc4118a1", 12:22:27 INFO - "slavebuilddir": "test" 12:22:27 INFO - } 12:22:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 12:22:27 INFO - Running post-action listener: _resource_record_post_action 12:22:27 INFO - ##### 12:22:27 INFO - ##### Running download-and-extract step. 12:22:27 INFO - ##### 12:22:27 INFO - Running pre-action listener: _resource_record_pre_action 12:22:27 INFO - Running main action method: download_and_extract 12:22:27 INFO - mkdir: /builds/slave/test/build/tests 12:22:27 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')]} 12:22:27 INFO - https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:22:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:22:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:22:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:22:33 INFO - Downloaded 1327 bytes. 12:22:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 12:22:33 INFO - Using the following test package requirements: 12:22:33 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:22:33 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:22:33 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:22:33 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:22:33 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 12:22:33 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:22:33 INFO - u'jsshell-linux-x86_64.zip'], 12:22:33 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:22:33 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:22:33 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 12:22:33 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:22:33 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 12:22:33 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:22:33 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 12:22:33 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:22:33 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:22:33 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 12:22:33 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:22:33 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:22:33 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')]} 12:22:33 INFO - https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:22:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:22:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:22:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:22:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:22:36 INFO - Downloaded 24185717 bytes. 12:22:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:22:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:22:37 INFO - Return code: 0 12:22:37 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:37 INFO - https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:22:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:22:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:22:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 12:22:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:22:44 INFO - Downloaded 24185717 bytes. 12:22:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:22:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:22:45 INFO - Return code: 0 12:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:45 INFO - https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 12:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:22:49 INFO - Downloaded 10840145 bytes. 12:22:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:22:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:22:49 INFO - Return code: 0 12:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:49 INFO - https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:22:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:22:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:22:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:22:52 INFO - Downloaded 56005149 bytes. 12:22:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:22:52 INFO - mkdir: /builds/slave/test/properties 12:22:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:22:52 INFO - Writing to file /builds/slave/test/properties/build_url 12:22:52 INFO - Contents: 12:22:52 INFO - build_url:https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 12:22:52 INFO - Running post-action listener: _resource_record_post_action 12:22:52 INFO - Running post-action listener: set_extra_try_arguments 12:22:52 INFO - ##### 12:22:52 INFO - ##### Running populate-webroot step. 12:22:52 INFO - ##### 12:22:52 INFO - Running pre-action listener: _resource_record_pre_action 12:22:52 INFO - Running main action method: populate_webroot 12:22:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:22:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:22:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:22:52 INFO - '--tppagecycles', 12:22:52 INFO - '7'], 12:22:52 INFO - 'tests': ['tsvgm']}}, 12:22:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:22:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:22:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:22:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:22:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:22:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:22:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:52 INFO - 'talos_options': ['--disable-e10s'], 12:22:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:22:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:52 INFO - 'talos_options': ['--disable-e10s'], 12:22:52 INFO - 'tests': ['damp', 'tps']}, 12:22:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:52 INFO - 'tests': ['damp', 'tps']}, 12:22:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:22:52 INFO - 'tests': ['dromaeo_dom']}, 12:22:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:22:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:22:52 INFO - 'tests': ['a11yr', 12:22:52 INFO - 'ts_paint', 12:22:52 INFO - 'tpaint', 12:22:52 INFO - 'sessionrestore', 12:22:52 INFO - 'sessionrestore_no_auto_restore', 12:22:52 INFO - 'tabpaint']}, 12:22:52 INFO - 'other-e10s': {'tests': ['a11yr', 12:22:52 INFO - 'ts_paint', 12:22:52 INFO - 'tpaint', 12:22:52 INFO - 'sessionrestore', 12:22:52 INFO - 'sessionrestore_no_auto_restore', 12:22:52 INFO - 'tabpaint']}, 12:22:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:22:52 INFO - 'ts_paint', 12:22:52 INFO - 'tpaint', 12:22:52 INFO - 'sessionrestore', 12:22:52 INFO - 'sessionrestore_no_auto_restore', 12:22:52 INFO - 'tabpaint']}, 12:22:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:22:52 INFO - 'ts_paint', 12:22:52 INFO - 'tpaint', 12:22:52 INFO - 'sessionrestore', 12:22:52 INFO - 'sessionrestore_no_auto_restore', 12:22:52 INFO - 'tabpaint']}, 12:22:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:22:52 INFO - 'tests': ['a11yr', 12:22:52 INFO - 'ts_paint', 12:22:52 INFO - 'tpaint', 12:22:52 INFO - 'sessionrestore', 12:22:52 INFO - 'sessionrestore_no_auto_restore', 12:22:52 INFO - 'tabpaint']}, 12:22:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:22:52 INFO - 'tests': ['a11yr', 12:22:52 INFO - 'ts_paint', 12:22:52 INFO - 'tpaint', 12:22:52 INFO - 'sessionrestore', 12:22:52 INFO - 'sessionrestore_no_auto_restore', 12:22:52 INFO - 'tabpaint']}, 12:22:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:22:52 INFO - 'tests': ['tsvgx', 12:22:52 INFO - 'tsvgr_opacity', 12:22:52 INFO - 'tart', 12:22:52 INFO - 'tscrollx', 12:22:52 INFO - 'cart']}, 12:22:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:22:52 INFO - 'tsvgr_opacity', 12:22:52 INFO - 'tart', 12:22:52 INFO - 'tscrollx', 12:22:52 INFO - 'cart']}, 12:22:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:52 INFO - 'talos_options': ['--disable-e10s'], 12:22:52 INFO - 'tests': ['tp5o']}, 12:22:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:52 INFO - 'tests': ['tp5o']}, 12:22:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:52 INFO - 'talos_options': ['--disable-e10s', 12:22:52 INFO - '--xperf_path', 12:22:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:52 INFO - 'tests': ['tp5n']}, 12:22:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:22:52 INFO - 'talos_options': ['--xperf_path', 12:22:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:22:52 INFO - 'tests': ['tp5n']}}, 12:22:52 INFO - 'talos.zip': {'path': '', 12:22:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:22:52 INFO - Running post-action listener: _resource_record_post_action 12:22:52 INFO - ##### 12:22:52 INFO - ##### Running create-virtualenv step. 12:22:52 INFO - ##### 12:22:52 INFO - Running pre-action listener: _resource_record_pre_action 12:22:52 INFO - Running main action method: create_virtualenv 12:22:52 INFO - Creating virtualenv /builds/slave/test/build/venv 12:22:52 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 12:22:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:22:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:22:53 INFO - Using real prefix '/usr' 12:22:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:22:53 INFO - Installing distribute.............................................................................................................................................................................................done. 12:22:55 INFO - Installing pip.................done. 12:22:55 INFO - Return code: 0 12:22:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:22: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')]} 12:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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')]} 12:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:55 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 0x7f21c7e2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5410>, '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 0x2cb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', '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 12:22:55 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 12:22:55 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 12:22:55 INFO - Using env: {'DISPLAY': ':0', 12:22:55 INFO - 'HOME': '/home/cltbld', 12:22:55 INFO - 'LANG': 'en_US.UTF-8', 12:22:55 INFO - 'LANGUAGE': 'en_US:en', 12:22:55 INFO - 'LOGNAME': 'cltbld', 12:22:55 INFO - 'MAIL': '/var/mail/cltbld', 12:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:55 INFO - 'MOZ_NO_REMOTE': '1', 12:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:55 INFO - 'NO_EM_RESTART': '1', 12:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:55 INFO - 'PWD': '/builds/slave/test', 12:22:55 INFO - 'SHELL': '/bin/bash', 12:22:55 INFO - 'SHLVL': '1', 12:22:55 INFO - 'TERM': 'linux', 12:22:55 INFO - 'TMOUT': '86400', 12:22:55 INFO - 'USER': 'cltbld', 12:22:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', 12:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:55 INFO - '_': '/tools/buildbot/bin/python'} 12:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:55 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 12:22:55 INFO - Cleaning up... 12:22:55 INFO - Return code: 0 12:22:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:22: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')]} 12:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22: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')]} 12:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21c7e2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5410>, '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 0x2cb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', '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 12:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:22:55 INFO - Using env: {'DISPLAY': ':0', 12:22:55 INFO - 'HOME': '/home/cltbld', 12:22:55 INFO - 'LANG': 'en_US.UTF-8', 12:22:55 INFO - 'LANGUAGE': 'en_US:en', 12:22:55 INFO - 'LOGNAME': 'cltbld', 12:22:55 INFO - 'MAIL': '/var/mail/cltbld', 12:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:55 INFO - 'MOZ_NO_REMOTE': '1', 12:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:55 INFO - 'NO_EM_RESTART': '1', 12:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:55 INFO - 'PWD': '/builds/slave/test', 12:22:55 INFO - 'SHELL': '/bin/bash', 12:22:55 INFO - 'SHLVL': '1', 12:22:55 INFO - 'TERM': 'linux', 12:22:55 INFO - 'TMOUT': '86400', 12:22:55 INFO - 'USER': 'cltbld', 12:22:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', 12:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:55 INFO - '_': '/tools/buildbot/bin/python'} 12:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:55 INFO - Downloading/unpacking psutil>=0.7.1 12:22:55 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 12:22:55 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 12:22:55 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 12:22:55 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 12:22:55 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 12:22:55 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 12:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:57 INFO - Installing collected packages: psutil 12:22:57 INFO - Running setup.py install for psutil 12:22:57 INFO - building 'psutil._psutil_linux' extension 12:22:57 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 12:22:58 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 12:22:58 INFO - building 'psutil._psutil_posix' extension 12:22:58 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 12:22:58 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 12:22:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:22:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:22:58 INFO - Successfully installed psutil 12:22:58 INFO - Cleaning up... 12:22:58 INFO - Return code: 0 12:22:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:22:58 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')]} 12:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:58 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')]} 12:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21c7e2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5410>, '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 0x2cb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', '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 12:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:22:58 INFO - Using env: {'DISPLAY': ':0', 12:22:58 INFO - 'HOME': '/home/cltbld', 12:22:58 INFO - 'LANG': 'en_US.UTF-8', 12:22:58 INFO - 'LANGUAGE': 'en_US:en', 12:22:58 INFO - 'LOGNAME': 'cltbld', 12:22:58 INFO - 'MAIL': '/var/mail/cltbld', 12:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:22:58 INFO - 'MOZ_NO_REMOTE': '1', 12:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:22:58 INFO - 'NO_EM_RESTART': '1', 12:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:22:58 INFO - 'PWD': '/builds/slave/test', 12:22:58 INFO - 'SHELL': '/bin/bash', 12:22:58 INFO - 'SHLVL': '1', 12:22:58 INFO - 'TERM': 'linux', 12:22:58 INFO - 'TMOUT': '86400', 12:22:58 INFO - 'USER': 'cltbld', 12:22:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', 12:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:22:58 INFO - '_': '/tools/buildbot/bin/python'} 12:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:22:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:23:00 INFO - Installing collected packages: mozsystemmonitor 12:23:00 INFO - Running setup.py install for mozsystemmonitor 12:23:00 INFO - Successfully installed mozsystemmonitor 12:23:00 INFO - Cleaning up... 12:23:00 INFO - Return code: 0 12:23:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f21c7e2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5410>, '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 0x2cb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', '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 12:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:23:00 INFO - Using env: {'DISPLAY': ':0', 12:23:00 INFO - 'HOME': '/home/cltbld', 12:23:00 INFO - 'LANG': 'en_US.UTF-8', 12:23:00 INFO - 'LANGUAGE': 'en_US:en', 12:23:00 INFO - 'LOGNAME': 'cltbld', 12:23:00 INFO - 'MAIL': '/var/mail/cltbld', 12:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:00 INFO - 'MOZ_NO_REMOTE': '1', 12:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:00 INFO - 'NO_EM_RESTART': '1', 12:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:00 INFO - 'PWD': '/builds/slave/test', 12:23:00 INFO - 'SHELL': '/bin/bash', 12:23:00 INFO - 'SHLVL': '1', 12:23:00 INFO - 'TERM': 'linux', 12:23:00 INFO - 'TMOUT': '86400', 12:23:00 INFO - 'USER': 'cltbld', 12:23:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', 12:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:00 INFO - '_': '/tools/buildbot/bin/python'} 12:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:00 INFO - Downloading/unpacking blobuploader==1.2.4 12:23:00 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 12:23:00 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 12:23:00 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 12:23:00 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 12:23:00 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 12:23:00 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 12:23:02 INFO - Downloading blobuploader-1.2.4.tar.gz 12:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:23:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:23:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:23:03 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 12:23:03 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 12:23:03 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 12:23:03 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 12:23:03 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 12:23:03 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 12:23:03 INFO - Downloading docopt-0.6.1.tar.gz 12:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:23:03 INFO - Installing collected packages: blobuploader, requests, docopt 12:23:03 INFO - Running setup.py install for blobuploader 12:23:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:23:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:23:03 INFO - Running setup.py install for requests 12:23:04 INFO - Running setup.py install for docopt 12:23:04 INFO - Successfully installed blobuploader requests docopt 12:23:04 INFO - Cleaning up... 12:23:04 INFO - Return code: 0 12:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:04 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 0x7f21c7e2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5410>, '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 0x2cb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', '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 12:23:04 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 12:23:04 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 12:23:04 INFO - Using env: {'DISPLAY': ':0', 12:23:04 INFO - 'HOME': '/home/cltbld', 12:23:04 INFO - 'LANG': 'en_US.UTF-8', 12:23:04 INFO - 'LANGUAGE': 'en_US:en', 12:23:04 INFO - 'LOGNAME': 'cltbld', 12:23:04 INFO - 'MAIL': '/var/mail/cltbld', 12:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:04 INFO - 'MOZ_NO_REMOTE': '1', 12:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:04 INFO - 'NO_EM_RESTART': '1', 12:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:04 INFO - 'PWD': '/builds/slave/test', 12:23:04 INFO - 'SHELL': '/bin/bash', 12:23:04 INFO - 'SHLVL': '1', 12:23:04 INFO - 'TERM': 'linux', 12:23:04 INFO - 'TMOUT': '86400', 12:23:04 INFO - 'USER': 'cltbld', 12:23:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', 12:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:04 INFO - '_': '/tools/buildbot/bin/python'} 12:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:04 INFO - Running setup.py (path:/tmp/pip-bR6xqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:04 INFO - Running setup.py (path:/tmp/pip-9au3x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:04 INFO - Running setup.py (path:/tmp/pip-ZWzE_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:04 INFO - Running setup.py (path:/tmp/pip-BprGgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:04 INFO - Running setup.py (path:/tmp/pip-Wg04EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:04 INFO - Running setup.py (path:/tmp/pip-CrAeGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:04 INFO - Running setup.py (path:/tmp/pip-nR1opa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:04 INFO - Running setup.py (path:/tmp/pip-Azl69H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:05 INFO - Running setup.py (path:/tmp/pip-nFHMbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:05 INFO - Running setup.py (path:/tmp/pip-j8wTw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:05 INFO - Running setup.py (path:/tmp/pip-clM38h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:05 INFO - Running setup.py (path:/tmp/pip-ehzrhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:05 INFO - Running setup.py (path:/tmp/pip-kQvBDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:05 INFO - Running setup.py (path:/tmp/pip-LUcZY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:05 INFO - Running setup.py (path:/tmp/pip-F9uEGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:05 INFO - Running setup.py (path:/tmp/pip-q2qCR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:05 INFO - Running setup.py (path:/tmp/pip-T3gZrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:23:05 INFO - Running setup.py install for manifestparser 12:23:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:23:05 INFO - Running setup.py install for mozcrash 12:23:05 INFO - Running setup.py install for mozdebug 12:23:05 INFO - Running setup.py install for mozdevice 12:23:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:23:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:23:06 INFO - Running setup.py install for mozfile 12:23:06 INFO - Running setup.py install for mozhttpd 12:23:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:23:06 INFO - Running setup.py install for mozinfo 12:23:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:23:06 INFO - Running setup.py install for mozInstall 12:23:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:23:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:23:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:23:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:23:06 INFO - Running setup.py install for mozleak 12:23:06 INFO - Running setup.py install for mozlog 12:23:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:23:06 INFO - Running setup.py install for moznetwork 12:23:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:23:06 INFO - Running setup.py install for mozprocess 12:23:06 INFO - Running setup.py install for mozprofile 12:23:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:23:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:23:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:23:07 INFO - Running setup.py install for mozrunner 12:23:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:23:07 INFO - Running setup.py install for mozscreenshot 12:23:07 INFO - Running setup.py install for moztest 12:23:07 INFO - Running setup.py install for mozversion 12:23:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:23:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:23:07 INFO - Cleaning up... 12:23:07 INFO - Return code: 0 12:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:07 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 0x7f21c7e2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5410>, '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 0x2cb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', '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 12:23:07 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 12:23:07 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 12:23:07 INFO - Using env: {'DISPLAY': ':0', 12:23:07 INFO - 'HOME': '/home/cltbld', 12:23:07 INFO - 'LANG': 'en_US.UTF-8', 12:23:07 INFO - 'LANGUAGE': 'en_US:en', 12:23:07 INFO - 'LOGNAME': 'cltbld', 12:23:07 INFO - 'MAIL': '/var/mail/cltbld', 12:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:07 INFO - 'MOZ_NO_REMOTE': '1', 12:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:07 INFO - 'NO_EM_RESTART': '1', 12:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:07 INFO - 'PWD': '/builds/slave/test', 12:23:07 INFO - 'SHELL': '/bin/bash', 12:23:07 INFO - 'SHLVL': '1', 12:23:07 INFO - 'TERM': 'linux', 12:23:07 INFO - 'TMOUT': '86400', 12:23:07 INFO - 'USER': 'cltbld', 12:23:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', 12:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:07 INFO - '_': '/tools/buildbot/bin/python'} 12:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:07 INFO - Running setup.py (path:/tmp/pip-pof_y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:07 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)) 12:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:07 INFO - Running setup.py (path:/tmp/pip-f7tcIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:07 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)) 12:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:07 INFO - Running setup.py (path:/tmp/pip-65IgRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:07 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)) 12:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:07 INFO - Running setup.py (path:/tmp/pip-PuQdhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:07 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)) 12:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:07 INFO - Running setup.py (path:/tmp/pip-hwk408-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:08 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)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:08 INFO - Running setup.py (path:/tmp/pip-NWP0Fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:08 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)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:08 INFO - Running setup.py (path:/tmp/pip-EmOPRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:08 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)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:08 INFO - Running setup.py (path:/tmp/pip-PD4cNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:08 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)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:08 INFO - Running setup.py (path:/tmp/pip-qYpjzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:08 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)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:08 INFO - Running setup.py (path:/tmp/pip-pAU56G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:08 INFO - Running setup.py (path:/tmp/pip-Ssr8iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:08 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)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:08 INFO - Running setup.py (path:/tmp/pip-KIet_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:08 INFO - Running setup.py (path:/tmp/pip-ZB_127-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:08 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)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:08 INFO - Running setup.py (path:/tmp/pip-jUN0o8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:08 INFO - Running setup.py (path:/tmp/pip-vkE97l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:08 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)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:08 INFO - Running setup.py (path:/tmp/pip-nDXJaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:08 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)) 12:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:08 INFO - Running setup.py (path:/tmp/pip-LPJxs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:08 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)) 12:23:08 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)) 12:23:08 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)) 12:23:08 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)) 12:23:08 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)) 12:23:08 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)) 12:23:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:23:08 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 12:23:08 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 12:23:08 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 12:23:08 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 12:23:08 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 12:23:08 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 12:23:10 INFO - Downloading blessings-1.6.tar.gz 12:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:23:10 INFO - Installing collected packages: blessings 12:23:10 INFO - Running setup.py install for blessings 12:23:10 INFO - Successfully installed blessings 12:23:10 INFO - Cleaning up... 12:23:11 INFO - Return code: 0 12:23:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:11 INFO - Reading from file tmpfile_stdout 12:23:11 INFO - Current package versions: 12:23:11 INFO - argparse == 1.2.1 12:23:11 INFO - blessings == 1.6 12:23:11 INFO - blobuploader == 1.2.4 12:23:11 INFO - docopt == 0.6.1 12:23:11 INFO - manifestparser == 1.1 12:23:11 INFO - mozInstall == 1.12 12:23:11 INFO - mozcrash == 0.17 12:23:11 INFO - mozdebug == 0.1 12:23:11 INFO - mozdevice == 0.48 12:23:11 INFO - mozfile == 1.2 12:23:11 INFO - mozhttpd == 0.7 12:23:11 INFO - mozinfo == 0.9 12:23:11 INFO - mozleak == 0.1 12:23:11 INFO - mozlog == 3.1 12:23:11 INFO - moznetwork == 0.27 12:23:11 INFO - mozprocess == 0.22 12:23:11 INFO - mozprofile == 0.28 12:23:11 INFO - mozrunner == 6.11 12:23:11 INFO - mozscreenshot == 0.1 12:23:11 INFO - mozsystemmonitor == 0.0 12:23:11 INFO - moztest == 0.7 12:23:11 INFO - mozversion == 1.4 12:23:11 INFO - psutil == 3.1.1 12:23:11 INFO - requests == 1.2.3 12:23:11 INFO - wsgiref == 0.1.2 12:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23: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')]} 12:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23: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')]} 12:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:11 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 0x7f21c7e2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5410>, '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 0x2cb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', '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 12:23:11 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 12:23:11 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 12:23:11 INFO - Using env: {'DISPLAY': ':0', 12:23:11 INFO - 'HOME': '/home/cltbld', 12:23:11 INFO - 'LANG': 'en_US.UTF-8', 12:23:11 INFO - 'LANGUAGE': 'en_US:en', 12:23:11 INFO - 'LOGNAME': 'cltbld', 12:23:11 INFO - 'MAIL': '/var/mail/cltbld', 12:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:11 INFO - 'MOZ_NO_REMOTE': '1', 12:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:11 INFO - 'NO_EM_RESTART': '1', 12:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:11 INFO - 'PWD': '/builds/slave/test', 12:23:11 INFO - 'SHELL': '/bin/bash', 12:23:11 INFO - 'SHLVL': '1', 12:23:11 INFO - 'TERM': 'linux', 12:23:11 INFO - 'TMOUT': '86400', 12:23:11 INFO - 'USER': 'cltbld', 12:23:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', 12:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:11 INFO - '_': '/tools/buildbot/bin/python'} 12:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:11 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)) 12:23:11 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)) 12:23:11 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)) 12:23:11 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)) 12:23:11 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)) 12:23:11 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)) 12:23:11 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)) 12:23:11 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)) 12:23:11 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)) 12:23:11 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)) 12:23:11 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)) 12:23:11 INFO - Cleaning up... 12:23:11 INFO - Return code: 0 12:23:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:23: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')]} 12:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23: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')]} 12:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:11 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 0x7f21c7e2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5410>, '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 0x2cb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', '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 12:23:11 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 12:23:11 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 12:23:11 INFO - Using env: {'DISPLAY': ':0', 12:23:11 INFO - 'HOME': '/home/cltbld', 12:23:11 INFO - 'LANG': 'en_US.UTF-8', 12:23:11 INFO - 'LANGUAGE': 'en_US:en', 12:23:11 INFO - 'LOGNAME': 'cltbld', 12:23:11 INFO - 'MAIL': '/var/mail/cltbld', 12:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:11 INFO - 'MOZ_NO_REMOTE': '1', 12:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:11 INFO - 'NO_EM_RESTART': '1', 12:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:11 INFO - 'PWD': '/builds/slave/test', 12:23:11 INFO - 'SHELL': '/bin/bash', 12:23:11 INFO - 'SHLVL': '1', 12:23:11 INFO - 'TERM': 'linux', 12:23:11 INFO - 'TMOUT': '86400', 12:23:11 INFO - 'USER': 'cltbld', 12:23:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', 12:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:11 INFO - '_': '/tools/buildbot/bin/python'} 12:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:11 INFO - Downloading/unpacking jsonschema 12:23:11 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 12:23:11 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 12:23:11 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 12:23:11 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 12:23:11 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 12:23:11 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 12:23:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:23:13 INFO - Downloading/unpacking functools32 (from jsonschema) 12:23:13 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 12:23:13 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 12:23:13 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 12:23:13 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 12:23:13 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 12:23:13 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 12:23:13 INFO - Downloading functools32-3.2.3-2.tar.gz 12:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:23:13 INFO - warning: no files found matching '*.txt' 12:23:13 INFO - no previously-included directories found matching 'build' 12:23:13 INFO - no previously-included directories found matching 'dist' 12:23:13 INFO - no previously-included directories found matching '.git*' 12:23:13 INFO - Installing collected packages: jsonschema, functools32 12:23:13 INFO - Running setup.py install for functools32 12:23:14 INFO - warning: no files found matching '*.txt' 12:23:14 INFO - no previously-included directories found matching 'build' 12:23:14 INFO - no previously-included directories found matching 'dist' 12:23:14 INFO - no previously-included directories found matching '.git*' 12:23:14 INFO - Successfully installed jsonschema functools32 12:23:14 INFO - Cleaning up... 12:23:14 INFO - Return code: 0 12:23:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:23:14 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')]} 12:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:14 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')]} 12:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21c7e2ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5410>, '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 0x2cb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', '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 12:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:23:14 INFO - Using env: {'DISPLAY': ':0', 12:23:14 INFO - 'HOME': '/home/cltbld', 12:23:14 INFO - 'LANG': 'en_US.UTF-8', 12:23:14 INFO - 'LANGUAGE': 'en_US:en', 12:23:14 INFO - 'LOGNAME': 'cltbld', 12:23:14 INFO - 'MAIL': '/var/mail/cltbld', 12:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:14 INFO - 'MOZ_NO_REMOTE': '1', 12:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:14 INFO - 'NO_EM_RESTART': '1', 12:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:14 INFO - 'PWD': '/builds/slave/test', 12:23:14 INFO - 'SHELL': '/bin/bash', 12:23:14 INFO - 'SHLVL': '1', 12:23:14 INFO - 'TERM': 'linux', 12:23:14 INFO - 'TMOUT': '86400', 12:23:14 INFO - 'USER': 'cltbld', 12:23:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', 12:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:14 INFO - '_': '/tools/buildbot/bin/python'} 12:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:14 INFO - Downloading/unpacking flake8 12:23:14 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 12:23:14 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 12:23:14 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 12:23:14 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 12:23:14 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 12:23:14 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 12:23:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:23:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:23:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 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 12:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:23:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:23:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:23:16 INFO - no previously-included directories found matching 'docs/_build' 12:23:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:23:17 INFO - Running setup.py install for pep8 12:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:23:17 INFO - no previously-included directories found matching 'docs/_build' 12:23:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:23:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:23:17 INFO - Cleaning up... 12:23:17 INFO - Return code: 0 12:23:17 INFO - Running post-action listener: _resource_record_post_action 12:23:17 INFO - Running post-action listener: _start_resource_monitoring 12:23:17 INFO - Starting resource monitoring. 12:23:17 INFO - ##### 12:23:17 INFO - ##### Running install step. 12:23:17 INFO - ##### 12:23:17 INFO - Running pre-action listener: _resource_record_pre_action 12:23:17 INFO - Running main action method: install 12:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:17 INFO - Reading from file tmpfile_stdout 12:23:17 INFO - Detecting whether we're running mozinstall >=1.0... 12:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:23:17 INFO - Reading from file tmpfile_stdout 12:23:17 INFO - Output received: 12:23:17 INFO - Usage: mozinstall [options] installer 12:23:17 INFO - Options: 12:23:17 INFO - -h, --help show this help message and exit 12:23:17 INFO - -d DEST, --destination=DEST 12:23:17 INFO - Directory to install application into. [default: 12:23:17 INFO - "/builds/slave/test"] 12:23:17 INFO - --app=APP Application being installed. [default: firefox] 12:23:17 INFO - mkdir: /builds/slave/test/build/application 12:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:23:30 INFO - Reading from file tmpfile_stdout 12:23:30 INFO - Output received: 12:23:30 INFO - /builds/slave/test/build/application/firefox/firefox 12:23:30 INFO - Running post-action listener: _resource_record_post_action 12:23:30 INFO - ##### 12:23:30 INFO - ##### Running run-tests step. 12:23:30 INFO - ##### 12:23:30 INFO - Running pre-action listener: _resource_record_pre_action 12:23:30 INFO - Running main action method: run_tests 12:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:23:30 INFO - Python 2.7.3 12:23:30 INFO - Return code: 0 12:23:30 INFO - grabbing minidump binary from tooltool 12:23:30 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')]} 12:23:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb5410>, '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 0x2cb6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:23:30 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 12:23:30 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 12:23:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:23:30 INFO - Return code: 0 12:23:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:23:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:23:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:23:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:23:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:23:31 INFO - Return code: 0 12:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:23:31 INFO - Using env: {'DISPLAY': ':0', 12:23:31 INFO - 'HOME': '/home/cltbld', 12:23:31 INFO - 'LANG': 'en_US.UTF-8', 12:23:31 INFO - 'LANGUAGE': 'en_US:en', 12:23:31 INFO - 'LOGNAME': 'cltbld', 12:23:31 INFO - 'MAIL': '/var/mail/cltbld', 12:23:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:23:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:31 INFO - 'MOZ_NO_REMOTE': '1', 12:23:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:31 INFO - 'NO_EM_RESTART': '1', 12:23:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:31 INFO - 'PWD': '/builds/slave/test', 12:23:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:23:31 INFO - 'SHELL': '/bin/bash', 12:23:31 INFO - 'SHLVL': '1', 12:23:31 INFO - 'TERM': 'linux', 12:23:31 INFO - 'TMOUT': '86400', 12:23:31 INFO - 'USER': 'cltbld', 12:23:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335', 12:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:31 INFO - '_': '/tools/buildbot/bin/python'} 12:23:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:23:31 INFO - mozversion application_buildid: 20160615093425 12:23:31 INFO - mozversion application_changeset: 3dda03d4037e84f6a646ceb934e4e5e3afd7ec29 12:23:31 INFO - mozversion application_display_name: Firefox 12:23:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:23:31 INFO - mozversion application_name: Firefox 12:23:31 INFO - mozversion application_remotingname: firefox 12:23:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:23:31 INFO - mozversion application_vendor: Mozilla 12:23:31 INFO - mozversion application_version: 48.0 12:23:31 INFO - mozversion platform_buildid: 20160615093425 12:23:31 INFO - mozversion platform_changeset: 3dda03d4037e84f6a646ceb934e4e5e3afd7ec29 12:23:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:23:31 INFO - mozversion platform_version: 48.0 12:23:31 INFO - using testdate: 1466018611 12:23:31 INFO - actual date: 1466018611 12:23:31 INFO - starting webserver on 'localhost:45578' 12:23:31 INFO - SUITE-START | Running 2 tests 12:23:31 INFO - TEST-START | dromaeo_css 12:23:31 INFO - operating with platform_type : linux_ 12:23:31 INFO - Initialising browser for dromaeo_css test... 12:23:31 INFO - TEST-INFO | started process 9091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNJEfR2/profile http://localhost:45578/getInfo.html) 12:23:35 INFO - PROCESS | 9091 | __metrics Screen width/height:1600/1200 12:23:35 INFO - PROCESS | 9091 | colorDepth:24 12:23:35 INFO - PROCESS | 9091 | Browser inner width/height: 1024/697 12:23:35 INFO - PROCESS | 9091 | __metrics 12:23:37 ERROR - PROCESS | 9091 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:23:38 INFO - TEST-INFO | 9091: exit 0 12:23:38 INFO - Browser initialized. 12:23:38 INFO - Running cycle 1/1 for dromaeo_css test... 12:23:38 INFO - TEST-INFO | started process 9180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNJEfR2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:23:49 INFO - PROCESS | 9180 | RSS: Main: 141058048 12:23:49 INFO - PROCESS | 9180 | 12:24:40 INFO - PROCESS | 9180 | 1466018680815 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] 12:26:48 INFO - PROCESS | 9180 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45578/tests/dromaeo/cssquery-ext.html) 12:26:49 INFO - PROCESS | 9180 | RSS: Main: 250806272 12:26:49 INFO - PROCESS | 9180 | 12:29:51 INFO - PROCESS | 9180 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-ext.html (next: http://localhost:45578/tests/dromaeo/cssquery-jquery.html) 12:29:52 INFO - PROCESS | 9180 | RSS: Main: 234496000 12:29:52 INFO - PROCESS | 9180 | 12:32:54 INFO - PROCESS | 9180 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45578/tests/dromaeo/cssquery-mootools.html) 12:32:54 INFO - PROCESS | 9180 | RSS: Main: 218275840 12:32:54 INFO - PROCESS | 9180 | 12:35:56 INFO - PROCESS | 9180 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45578/tests/dromaeo/cssquery-prototype.html) 12:35:56 INFO - PROCESS | 9180 | RSS: Main: 221548544 12:35:56 INFO - PROCESS | 9180 | 12:38:59 INFO - PROCESS | 9180 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45578/tests/dromaeo/cssquery-yui.html) 12:39:00 INFO - PROCESS | 9180 | RSS: Main: 210657280 12:39:00 INFO - PROCESS | 9180 | 12:42:02 INFO - PROCESS | 9180 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-yui.html (next: http://localhost:45578/tests/dromaeo/cssquery-dojo.html) 12:42:02 INFO - PROCESS | 9180 | RSS: Main: 254595072 12:42:02 INFO - PROCESS | 9180 | 12:42:02 INFO - PROCESS | 9180 | __start_tp_report 12:42:02 INFO - PROCESS | 9180 | _x_x_mozilla_page_load 12:42:02 INFO - PROCESS | 9180 | _x_x_mozilla_page_load_details 12:42:02 INFO - PROCESS | 9180 | |i|pagename|runs| 12:42:02 INFO - PROCESS | 9180 | |0;dojo.html;3271.8691252349904;3339.6994270515647;3373.5445714828493;3387.6612338766113;3409.7783644063134;5600.887982240348;5604.775808967642;5607.859803504914;5608.327000759915;5612.270404847374;5587.469190426913;5626.240457538231;5626.943730562693;5634.915476267849;5643.5203007744285;4986.252062190682;5090.058339207249;5144.56271216947;5187.507186817265;5234.26720259164;5059.721715305656;5097.260897169908;5143.0485360208295;5143.074246635604;5148.716820574867;5103.336566246383;5122.154844450662;5184.766685499161;5219.947800521984;5223.71269580173;5175.197844334115;5190.896182076337;5203.167493201088;5204.0372531081875;5231.973840130775;5007;5008.799648014112;5101;5105.693658380509;5113.744312784346;5456.290682211326;5486.890262194774;5525.613207075507;5532.004239236936;5549.056660367747;5936.584439089265;5952.9107063394085;5956.16613674086;5968.134620480006;5978.133170690226;5983.670898100603;5994.820155395345;6053.697315134225;6069.964484780226;6084.178635884187;5596.552275817925;5626.324841019104;5639.746211420496;5639.915401268943;5642.7178641067785;5982.222311099529;6140.754369825247;6151.907721384183;6155.661438620829;6164.506839452833;5842.591018628656;5915.940840591625;5919.970400147971;5935.2877654681715;5936.673482958392;6018.458338749533;6035.124906888476;6035.6076855004285;6036.094585812163;6038.094285857069;5816.563757718188;5912.852178695567;5986.341502434729;6005.549583781234;6010.098485227163;5946.345901950782;5953.672548009815;5956.16613674086;5958.970205149033;5997.2803263607775;4552.817887284537;4558.817647294071;4559.293309537027;4560.201964656172;4595.678302518859;4025.6175663311938;4031.7580945143386;4068.5727998559723;4075.5313138989395;4115.97942010288;5705.144228365778;5731;5734.39788822176;5755.5683323750045;5762.596618236767;5975.701214939236;6029.758809647653;6033.879322413527;6036.728347224385;6040.124181993674;5656.660600363992;5748.655080695172;5753.827385178452;5808.186853840466;5817.912731309034;5079.6698214615935;5089.949100508948;5091.821786237464;5096.541311282002;5097.949020509747;6315.936840631535;6319.96840015797;6320.968395158086;6325.304216536178;6326.841828954221;5887.499562537147;5990.820275391745;6046.818595442144;6124.0201567748945;6124.755009799558;6225.844353891008;6229.247440103246;6266.060090986389;6268.310485846644;6287.119803227461;5713.057345538106;5885.087811389241;5885.823425297248;5891.3224979127945;5926.703664816656;5864.882702346014;5937.228160339128;5944.851378715567;5946;5989.071693887455;5821.359650438533;5867.295924489089;5871.559633027455;5871.559633027626;5878.941210587839;5734.5125664319;5826.854328641648;5838.095095260242;5875.265591801025;5893.852653683693;5723.513501352265;5783.739731712168;5788.652680839163;5802.7098645066735;5827.621204621686;5940.16837642739;5947.851303717442;5950.642961422329;5958.34458209588;5961.433663801932;5614.157876318585;5781.988152073286;5826.329972053099;5857.58996870232;5876.294844618673 12:42:02 INFO - PROCESS | 9180 | |1;ext.html;652.7584793626359;675.9455249810295;677.1231255524095;729.5294535024909;744.7914583916505;31825;32341;32363.838180809093;39784;40532.39201411981;42838;43222.78388608061;43443.78278108605;43488.56511434885;43557;7935.523868567876;8708.21626053655;8890.199882010618;8897.332700047522;8899.510526921016;10604.257701960865;10979.2863463875;10982.835257471144;10984.670459886216;10994.560217591286;10687;10738.677839664822;10747.677569672922;10748;10752.462376881163;10539.947300263488;10608.946955265252;10634.415107169103;10643.414612196326;10646.095081918047;10406.531706073245;10490.475476226235;10506.78986420275;10515.106215971651;10523.368597884151;42791.78604106991;43295.35056974148;43298.56701432977;43341.349879751826;43456.130877382595;3584.444411116281;3656.8354424050717;3658.140337020798;3888.7083468739675;4220.725652832556;31468.842655786575;32543.349133017444;32600;32647.183820404443;32730.345393092004;4469.128519938613;4581.3128030795315;4586.3579098926175;4587.839425620121;4600.677952543323;328506;330215;331043;332257;333425.99999999756;39686.60313396829;63003.36996629975;63408.36591634117;63596;63711.36288637147;38107.809460952514;38161.42757858634;38418.231635367134;38421.807890960925;38504.229915402095;17002.404915827887;17163.656726865393;17171.227294771765;17205.82794172042;17227.39704110375;12596.181248218836;13450.730985380238;13458.52895148665;13477.663058423423;14957.177355245565;9380.812383752424;9384.67153649619;9412.435253884789;9487.193588544913;9487.241020718326;3594.5686517617532;3691;3734.9626503734617;3736.23407201523;3769.095417099931;1108.8336749487642;1118.9690711358858;1138.1236447935044;1154.215133709069;1176.8764279750503;32742.67257327396;33596.83201584026;34017.82991085029;34147;34680.65319346825;1122.5734220996133;1150.0512077536066;1191.1602320364123;1239.0149830884468;1249.4002878618314;15327.46353877609;16137.193140342935;16233.51299461018;16589.751153732705;16745.916270418813;439014;444189;446425;446496;446501;61248.387516125156;61821;61900;61947;61984.69007655023;1320.491610729876;1415.6036309833057;1423.939165321821;1499.2428823444309;1613.6207991122078;30091.247718807204;31015.68984310128;33349.666503335626;33558.832205838815;34120.48819267663;52597.47402525926;53380.46619533755;53439;53539.46460535501;53568.73215633897;359344;361398;361742;361948;362946;29909.401811964075;31231.687683122876;31241.843790780902;31274;31274.843625781727;51059.2341114891;51480.22779658233;51583.742081289354;52441;53239.733801330745;41803.58196417997;41945;42490.78754606207;42524.362134568626;43421.348679769195;40173.799131004154;41243;42333;42338.57661423346;42623;43179.35230971601;43891.34162987622;44303.556964431235;44386.334204987594;44890.63320250929;36982.44526332161;37948.62051379451;38349;38498.61501385062;38499.615003849605;28895.133146005654;29627.555586665785;29833.55249671213;29873.551896722;29891.55162672605 12:42:02 INFO - PROCESS | 9180 | |2;jquery.html;411.60897147709676;433.14237809137927;434.5458995349861;442.48008589906857;449.39331901932394;18439.446816595508;18508.537286567844;18956.431307060793;19102.808971910275;19277.132529036193;19777.307794227207;19817.207311707516;20507.589848203028;20548.589028219427;20579.27972520962;5712.22884910536;5760.999999999989;5966.284045914496;5972.79095231667;5984.611000284967;4288.078063216408;5852.970735146339;5922.763089476437;6166.84582885427;6467.773627923024;6440.80677579671;6443.452306553949;6456.806295811133;6457.612543247396;6457.773977910774;5460.754266058037;5745.798897038583;5747.2241247431475;5751.827445176651;6402.13571167891;3866.3620502617036;5462.5083742462975;5619.775208991636;5638.774449022034;5685.516731077863;13283.3358332083;13940.37268322928;14017.369218385094;14067.507637232648;14159.150450972975;2273.8654224699135;2327.2087490253393;2332.9035353383883;2451.681281433402;2900.1734505665995;9970.551325190383;10625.096866766256;10648;12671.683207919783;14541.691247787645;1943.630710165064;1957.3736404350614;1991.5220347116588;2039.428959891218;2055.804698553635;71995;73728.63135684341;75874;77852.22147778506;80766.59616701938;11288.322700637988;11394.487248073856;11472.88527114718;11605.245659032305;11833.408329583486;16178.67642647164;16275.837241627669;16368.918155409146;16369.42707005249;16408.09755463461;8900.243479304203;8901.421407608485;8936.195742383086;8969.865452018224;8974.955125224333;8685.609147588373;8709.869351959725;8760.430572012927;8816.735497935073;8853.937527496613;5022.347094877716;5060.822871199564;5073.518015788494;5116.155834287375;5124.5131712487255;1816.1281253236796;1943.7667479902502;1963.448875388427;2000.1999200319697;2025.9493512662007;975.4342481360794;1021.8569400283966;1028.290479569095;1071.1591400750374;1114.7380365614074;17571.648567028587;17816.643667126584;17885.10574471297;19477.610447790965;19763;1078.094400703413;1091.5906535049357;1103.1450625765096;1105.2263415609107;1132.2017977325966;10373.273870828969;10797.082248009006;10877.23859329855;10891.128709703205;10934.234603577674;385791;388557;551955;560685;570444;86450.56774716087;88405;99915.50042249743;102338;104189.47905260425;1087.6410784441116;1119.468252580018;1126.391748455841;1127.205320249206;1129.2377645089696;16552.42066527666;16942.40701575439;16981.915090424467;17488.91255543765;17843.73234401511;36466;36699.08252293714;40513.39229911612;41300.173996520505;41362.172756544096;50359.74820125876;51830.48169518256;52499.73750131225;56912.43087569237;57258.427415726976;8963;9030;9056.547172641473;9160.221381182673;9265.397749146285;10207.693769186937;12678.175918565265;13338.466461341826;13552.186868787905;14150.221737804519;11995.460204291003;12085.274883507018;12138.089643276613;12180.086493512845;12384.81422778641;11750.47243858293;11927.165098443025;11955.820662690241;12177.147599667938;12315.076369272161;11820.349880756641;11823.231489953125;12206.32865192423;12292.323922184365;12376.566820161252;9162.404443711137;9188;9239.584218710308;9240;9412.576434060347;9084.954575227082;11771.176017678681;11915.790946477602;11970.281783092694;12001.63995080149 12:42:02 INFO - PROCESS | 9180 | |3;mootools.html;1403.410567561624;1608.7667288243204;1649.1918959709747;1868.8603146713515;1985.8892093366737;7667.616619169047;8313.168683131684;8465.957670211656;8507.702230421937;8519.95740021299;8375.664973401072;8518.574071296425;8554.101819308977;8566.05773364931;8572.871406928902;2455.287966489716;2468.568000599888;2474.715407728116;2474.826762126652;2477.4549599088173;2407.0492155598527;2422.0432928993037;2431.586630272849;2434.196715084027;2461.4215659320043;2319.1535089692225;2353.8234632402555;2353.9058437662475;2359.304005318435;2379.6311571706415;2434.805215582749;2458.0659349447274;2459.2007597530783;2466.851988880655;2467.864267465289;2402.0631953538136;2437.512497500507;2448.424620214248;2449.64480150379;2451.178855083549;7473.476856620039;7628.847423051563;8714.912850871473;8768.649254029831;8786.956065219696;5342.973285133588;5432.266644003049;5437.211604317352;5487.067198576252;5489.6980666063355;3503.91240218994;3536.469529570559;3611.674949254553;3618.0412190769466;3655.689266412358;1147.736020715232;1162.9651110466616;1166.212806355715;1190.6309044196241;1205.7106294489347;11812.881871181264;11910.225835320676;11925.284482931052;12262.38688065602;12305.077119216005;4898.951010489921;4936.827211047596;4977.626677999092;4983.626228032912;4994.850154495371;10437.843432348522;10446.895531044744;10474.795398529115;10512.21158413122;10527.473626318653;5535.501804837584;5536.557075433956;5545.72271386429;5545.861353466195;5546.4453554644215;4988;5000.524950129732;5055.51972562606;5062.443131255559;5064.442911279756;4027.5368332641533;4081;4122.464079669624;4123.546409894969;4131.669466442678;1344.0793056756154;1347.6388847264334;1352.371147416456;1367.7811550151928;1373.1417863835104;1061.4692653673164;1069.315637991686;1075.8977897099762;1081.789051135021;1092.4428541443922;5938.851528711817;6045.063015232646;6136.509079273647;6154.415330543681;6231.22109736283;494.76004137993044;502.8189851653475;508.1995856525912;516.6254465512474;524.7114087251996;4076.408920706481;4094.61101195386;4180.122174343422;4207.305794543927;4224.471941007374;10385.169186465064;10829.025387715143;10840.67477975662;10844.349339039525;10874.347539147677;10488.63289784869;10646.893531064745;10658.360498370123;10661.573537058586;10675.412852293199;8252.092269850311;8259.545724985064;8284.917150828414;8321.04308004575;8335.45819521717;5830.18377427169;5917.28992520883;5930.673812940157;5933.436323549256;6074.3318234994995;9415.482148481899;9528.428294302365;9536.761580960532;9607.423554586747;9709.563069662023;9501.809963800824;9808;9867.753306167404;9890.406575605486;10090.949545252226;7521.285477879593;7541.35898448638;7565.054368203974;7612;7690.923090769021;8283.875741863998;8397.118302578141;8401.915980840113;8404.285635720787;8431.620577074169;7499.812504687208;7620.657070431955;7663.386929045774;7690.653920573475;7806.297433231037;7537.924620753723;7567.962160189384;7684;7698.307152356315;7731.188225236269;6972.233054363915;7042.154941407064;7061.505694601534;7067.293270673097;7070.540414873017;4645.140648979949;5266.315379000705;5334.253204551444;5500.834974950758;5578.748956297058;5281.419043905091;5324.345253459832;5388.488093631099;5389.8113566025;5430.918536222039 12:42:02 INFO - PROCESS | 9180 | |4;prototype.html;362.39841862508234;363.86900715742325;365.25123496831486;370.3592784482843;373.2479054704769;6238.0642903564485;6319.05214217867;6332.810015699531;6334.904976425358;6361.9045714314325;6227.719752611143;6234.84412889678;6237.906431403532;6249.968750156243;6250.874982500359;4551.726896386219;4660.464046634646;4809.951900480985;4811.975940120295;4820.132376172288;4765.594924431428;4803.351547541072;4807.61539076873;4808.374911261531;4814.590759785422;4581.839635612754;4784.784684689197;4794.448638406593;4794.712317260958;4796.160671882424;4632.536746325374;4701.576858082754;4705.058988202373;4727.621790256771;4750.477447480775;4203.4115223868685;4218.493780746299;4222.4299719538085;4226.049138943744;4230.603900712757;5964.373740757202;5968.7015649217365;5974.312954010257;5978.163057172;5982.611130276518;5549.667019978774;5570.3315602127595;5572;5574.108142697149;5586.35756887959;6440.871182576369;6573.375529324707;6578.671066446658;6586.176727909012;6588.341165883421;4686.53134686532;4701.7414042227665;4704.364910737041;4705.694129881546;4710.905781884378;6831.419329357011;6837.35045170708;6850.45196384293;6861.348171923659;6863.10779598654;4800.639952003614;4806.567408933212;4808.903821923612;4809.470958194665;4813.855584332476;4870.951290487121;4873.926891096637;4874.025194961022;4874.8050077997195;4876.366072410635;5550.500454959073;5555.97207019435;5560.221568980346;5565.248691426606;5578.609497335228;6462.256840463407;6606.240282367589;6649.601023938482;6679.833004174934;6692.531522793358;1690.3407671008317;1707.5304291319987;1711.076018949778;1714.2371644618274;1715.836995485427;1093.6554985179644;1138.499060413432;1153.371412580146;1159.8840115988503;1171.8593768747635;6453.838654033687;6568.6058836469965;6573.671316434255;6578.243501997332;6582.605043697394;6902.827429314207;6904.516683832184;6910.896336554955;6912.447004239649;6914.239433662293;6551.279359270477;6552.213734351813;6552.705128269239;6554.868902622016;6570.8357291068105;3668.779873207616;3710.6474884885893;3711.2391959648207;3711.777293362353;3713.9257214856093;7104.680289386886;7249.166345870187;7255.673494692752;7256.9274307256255;7268.781936541912;6967.512274140863;6984.266652001466;6995.1955525114245;7001.964990175016;7002.474814388941;7111.217766045731;7113.64431778409;7125.251848555827;7131.536450130829;7133.0013798067275;6884.862302753817;6890.552114112566;6892.310768923067;6903.447724181953;6909.343612356818;6628.370304821035;6773.119494465885;6782.084418603426;6788.49086318538;6789.592624442549;7210.242924493063;7230.13238411394;7235.167955685163;7243.710251589878;7244.963775181091;4825.203841366135;4834.927476087792;4837.2260438329695;4841.225403935354;4843.941324936958;6841.897371539331;6853.314668533306;6858.451323894176;6897.655117244218;6932.23745388017;6493.383128602775;6640.966795165993;6651.135352404156;6654.201495820533;6654.567453115532;6609.834754131185;6639.933600663931;6640.302768209269;6640.867182656223;6642.3025582315095;6499.4800415965665;6500.5449618526245;6504.772332968323;6505.8698826024165;6509.349065093453;6672.366125218096;6674.399304062657;6684.9972504122825;6685.8997115044285;6707.463402927851;6239.126522286974;6334.524910631629;6356.078368636614;6508.837279067871;6532.05285233629 12:42:02 INFO - PROCESS | 9180 | |5;yui.html;833.9291160251378;903.7062954539776;909.8953620333659;926.2543652359848;940.9905900940993;14577.854221457783;14676;14705.485308014222;14713.779293310608;14812.77780833287;13515.391807368667;13577.524786632444;13589;13592.932035339834;13602.319884005785;744.601638123604;881.5371929736875;898.5552151684925;900.5857305639381;903.7062954539768;884.0496466298722;891.7413949954505;894.1639567004838;897.8024834536392;899.0110878034143;928.5496534180917;930.1117432851644;930.9348345615809;932.9440233586007;933.54722959365;784.2236186175702;929.0338048429625;941.7598512379368;942.6606421688186;942.6936245720134;695.9443244540475;699.5557820783788;699.576756062585;700.0444393402968;700.3346820520526;14854.70290594182;14916.477923272741;14919.701605967819;14974.700505989927;14979.625509362244;14397.78403323951;14897.70204595902;14930.925345373313;15039.172845493493;15049.699006019928;12492.063095267891;12512;12549.184303020274;12612.180208286432;12773.105882588223;4025.1547175093265;4044.776119402985;4101.179764047202;4119.402686610425;4144.689148313858;55622.72188639071;55827;55851.441485585034;55934.44065559333;55964;11798;11858.881411185777;11959.521619135312;12066.517339306505;12263.93868030654;20917.89541052285;21357.46606334854;21375.03812328449;21400.35798926035;21403.67894481584;7396.260373962561;8282.17178282179;8811.823763524693;8932.151445612657;9037.59917212833;4874.122657921608;4988.401391833003;5005.424376196711;5050.419201791841;5086.669366491166;3722.7766334020043;3748.437734339871;3771.7548359356556;3772.43413487979;3777.036855601804;562.7833284185537;656.3043174235326;660.7555204574338;682.9009793580002;707.7204504220804;764.636797521173;771.1401787007446;799.6321692021735;818.4720855048461;819.4223072733828;9812.950935245279;10003.449810260505;10365.585376584851;10390.844137337946;10549.314294570828;757.6817736550662;760.8364201696662;764.2701220334567;818.2880893622468;823.7693445835175;4470.374147619336;4560.657950653715;4594.95405045952;4699.718016918996;4761.666683332202;64279.67860160763;64482;64633.35366646273;64872.35127648758;64885.02672459917;53409;56108.438915611136;56217.43782562204;56622.71688641613;56729;50944;51494.742526287126;52210;52386.21420678693;52463.47536524586;9169.312301577274;9186.908130918606;9341.953290233505;9358.578863951003;9397.342186046912;36409.27181456409;36860.81569592135;37552;38423;38622.42066369063;47996.28005579989;48167.75916120397;48629.75685121552;49554.25668614901;49792.50207497879;12887.548935787203;12944.8058279124;12990.285534295705;13137.146085504412;13389.263590502616;13826.239556824472;14210.502632407815;14311;14510.201938893462;14817.629559261104;12970.675733106747;13399.53101641438;13402.463901443833;13462.326883655582;13941.58175254744;13726.794098088736;13769.586912392644;13949.790753138508;14197.645058873612;14390.568282951528;13464.192148471124;13558.254296013814;13571;13686.178829270275;13741.519046833313;9955.104040636377;10162.136218421221;10579.62971296001;10599.470026498799;10724.249302548747;10982.725431864268;11361.715957101138;11491.310521368745;11521.82717259225;11576.47905844256 12:42:02 INFO - PROCESS | 9180 | __end_tp_report 12:42:02 INFO - PROCESS | 9180 | __start_cc_report 12:42:02 INFO - PROCESS | 9180 | _x_x_mozilla_cycle_collect,869 12:42:02 INFO - PROCESS | 9180 | __end_cc_report 12:42:02 INFO - PROCESS | 9180 | __startTimestamp1466019722544__endTimestamp 12:42:02 INFO - PROCESS | 9180 | 12:42:02 INFO - PROCESS | 9180 | ------- Summary: start ------- 12:42:02 INFO - PROCESS | 9180 | Number of tests: 6 12:42:02 INFO - PROCESS | 9180 | 12:42:02 INFO - PROCESS | 9180 | [#0] dojo.html Cycles:165 Average:5583.31 Median:5816.56 stddev:626.07 (10.8%) stddev-sans-first:601.16 12:42:02 INFO - PROCESS | 9180 | Values: 3271.9 3339.7 3373.5 3387.7 3409.8 5600.9 5604.8 5607.9 5608.3 5612.3 5587.5 5626.2 5626.9 5634.9 5643.5 4986.3 5090.1 5144.6 5187.5 5234.3 5059.7 5097.3 5143.0 5143.1 5148.7 5103.3 5122.2 5184.8 5219.9 5223.7 5175.2 5190.9 5203.2 5204.0 5232.0 5007.0 5008.8 5101.0 5105.7 5113.7 5456.3 5486.9 5525.6 5532.0 5549.1 5936.6 5952.9 5956.2 5968.1 5978.1 5983.7 5994.8 6053.7 6070.0 6084.2 5596.6 5626.3 5639.7 5639.9 5642.7 5982.2 6140.8 6151.9 6155.7 6164.5 5842.6 5915.9 5920.0 5935.3 5936.7 6018.5 6035.1 6035.6 6036.1 6038.1 5816.6 5912.9 5986.3 6005.5 6010.1 5946.3 5953.7 5956.2 5959.0 5997.3 4552.8 4558.8 4559.3 4560.2 4595.7 4025.6 4031.8 4068.6 4075.5 4116.0 5705.1 5731.0 5734.4 5755.6 5762.6 5975.7 6029.8 6033.9 6036.7 6040.1 5656.7 5748.7 5753.8 5808.2 5817.9 5079.7 5089.9 5091.8 5096.5 5097.9 6315.9 6320.0 6321.0 6325.3 6326.8 5887.5 5990.8 6046.8 6124.0 6124.8 6225.8 6229.2 6266.1 6268.3 6287.1 5713.1 5885.1 5885.8 5891.3 5926.7 5864.9 5937.2 5944.9 5946.0 5989.1 5821.4 5867.3 5871.6 5871.6 5878.9 5734.5 5826.9 5838.1 5875.3 5893.9 5723.5 5783.7 5788.7 5802.7 5827.6 5940.2 5947.9 5950.6 5958.3 5961.4 5614.2 5782.0 5826.3 5857.6 5876.3 12:42:02 INFO - PROCESS | 9180 | 12:42:02 INFO - PROCESS | 9180 | [#1] ext.html Cycles:180 Average:54806.63 Median:3657.49 stddev:100638.12 (2751.6%) stddev-sans-first:100838.29 12:42:02 INFO - PROCESS | 9180 | Values: 652.8 675.9 677.1 729.5 744.8 31825.0 32341.0 32363.8 39784.0 40532.4 42838.0 43222.8 43443.8 43488.6 43557.0 7935.5 8708.2 8890.2 8897.3 8899.5 10604.3 10979.3 10982.8 10984.7 10994.6 10687.0 10738.7 10747.7 10748.0 10752.5 10539.9 10608.9 10634.4 10643.4 10646.1 10406.5 10490.5 10506.8 10515.1 10523.4 42791.8 43295.4 43298.6 43341.3 43456.1 3584.4 3656.8 3658.1 3888.7 4220.7 31468.8 32543.3 32600.0 32647.2 32730.3 4469.1 4581.3 4586.4 4587.8 4600.7 328506.0 330215.0 331043.0 332257.0 333426.0 39686.6 63003.4 63408.4 63596.0 63711.4 38107.8 38161.4 38418.2 38421.8 38504.2 17002.4 17163.7 17171.2 17205.8 17227.4 12596.2 13450.7 13458.5 13477.7 14957.2 9380.8 9384.7 9412.4 9487.2 9487.2 3594.6 3691.0 3735.0 3736.2 3769.1 1108.8 1119.0 1138.1 1154.2 1176.9 32742.7 33596.8 34017.8 34147.0 34680.7 1122.6 1150.1 1191.2 1239.0 1249.4 15327.5 16137.2 16233.5 16589.8 16745.9 439014.0 444189.0 446425.0 446496.0 446501.0 61248.4 61821.0 61900.0 61947.0 61984.7 1320.5 1415.6 1423.9 1499.2 1613.6 30091.2 31015.7 33349.7 33558.8 34120.5 52597.5 53380.5 53439.0 53539.5 53568.7 359344.0 361398.0 361742.0 361948.0 362946.0 29909.4 31231.7 31241.8 31274.0 31274.8 51059.2 51480.2 51583.7 52441.0 53239.7 41803.6 41945.0 42490.8 42524.4 43421.3 40173.8 41243.0 42333.0 42338.6 42623.0 43179.4 43891.3 44303.6 44386.3 44890.6 36982.4 37948.6 38349.0 38498.6 38499.6 28895.1 29627.6 29833.6 29873.6 29891.6 12:42:02 INFO - PROCESS | 9180 | 12:42:02 INFO - PROCESS | 9180 | [#2] jquery.html Cycles:180 Average:28794.12 Median:20528.09 stddev:82232.27 (400.6%) stddev-sans-first:82435.33 12:42:02 INFO - PROCESS | 9180 | Values: 411.6 433.1 434.5 442.5 449.4 18439.4 18508.5 18956.4 19102.8 19277.1 19777.3 19817.2 20507.6 20548.6 20579.3 5712.2 5761.0 5966.3 5972.8 5984.6 4288.1 5853.0 5922.8 6166.8 6467.8 6440.8 6443.5 6456.8 6457.6 6457.8 5460.8 5745.8 5747.2 5751.8 6402.1 3866.4 5462.5 5619.8 5638.8 5685.5 13283.3 13940.4 14017.4 14067.5 14159.2 2273.9 2327.2 2332.9 2451.7 2900.2 9970.6 10625.1 10648.0 12671.7 14541.7 1943.6 1957.4 1991.5 2039.4 2055.8 71995.0 73728.6 75874.0 77852.2 80766.6 11288.3 11394.5 11472.9 11605.2 11833.4 16178.7 16275.8 16368.9 16369.4 16408.1 8900.2 8901.4 8936.2 8969.9 8975.0 8685.6 8709.9 8760.4 8816.7 8853.9 5022.3 5060.8 5073.5 5116.2 5124.5 1816.1 1943.8 1963.4 2000.2 2025.9 975.4 1021.9 1028.3 1071.2 1114.7 17571.6 17816.6 17885.1 19477.6 19763.0 1078.1 1091.6 1103.1 1105.2 1132.2 10373.3 10797.1 10877.2 10891.1 10934.2 385791.0 388557.0 551955.0 560685.0 570444.0 86450.6 88405.0 99915.5 102338.0 104189.5 1087.6 1119.5 1126.4 1127.2 1129.2 16552.4 16942.4 16981.9 17488.9 17843.7 36466.0 36699.1 40513.4 41300.2 41362.2 50359.7 51830.5 52499.7 56912.4 57258.4 8963.0 9030.0 9056.5 9160.2 9265.4 10207.7 12678.2 13338.5 13552.2 14150.2 11995.5 12085.3 12138.1 12180.1 12384.8 11750.5 11927.2 11955.8 12177.1 12315.1 11820.3 11823.2 12206.3 12292.3 12376.6 9162.4 9188.0 9239.6 9240.0 9412.6 9085.0 11771.2 11915.8 11970.3 12001.6 12:42:02 INFO - PROCESS | 9180 | 12:42:02 INFO - PROCESS | 9180 | [#3] mootools.html Cycles:180 Average:5789.82 Median:2779.17 stddev:3178.56 (114.4%) stddev-sans-first:3170.37 12:42:02 INFO - PROCESS | 9180 | Values: 1403.4 1608.8 1649.2 1868.9 1985.9 7667.6 8313.2 8466.0 8507.7 8520.0 8375.7 8518.6 8554.1 8566.1 8572.9 2455.3 2468.6 2474.7 2474.8 2477.5 2407.0 2422.0 2431.6 2434.2 2461.4 2319.2 2353.8 2353.9 2359.3 2379.6 2434.8 2458.1 2459.2 2466.9 2467.9 2402.1 2437.5 2448.4 2449.6 2451.2 7473.5 7628.8 8714.9 8768.6 8787.0 5343.0 5432.3 5437.2 5487.1 5489.7 3503.9 3536.5 3611.7 3618.0 3655.7 1147.7 1163.0 1166.2 1190.6 1205.7 11812.9 11910.2 11925.3 12262.4 12305.1 4899.0 4936.8 4977.6 4983.6 4994.9 10437.8 10446.9 10474.8 10512.2 10527.5 5535.5 5536.6 5545.7 5545.9 5546.4 4988.0 5000.5 5055.5 5062.4 5064.4 4027.5 4081.0 4122.5 4123.5 4131.7 1344.1 1347.6 1352.4 1367.8 1373.1 1061.5 1069.3 1075.9 1081.8 1092.4 5938.9 6045.1 6136.5 6154.4 6231.2 494.8 502.8 508.2 516.6 524.7 4076.4 4094.6 4180.1 4207.3 4224.5 10385.2 10829.0 10840.7 10844.3 10874.3 10488.6 10646.9 10658.4 10661.6 10675.4 8252.1 8259.5 8284.9 8321.0 8335.5 5830.2 5917.3 5930.7 5933.4 6074.3 9415.5 9528.4 9536.8 9607.4 9709.6 9501.8 9808.0 9867.8 9890.4 10090.9 7521.3 7541.4 7565.1 7612.0 7690.9 8283.9 8397.1 8401.9 8404.3 8431.6 7499.8 7620.7 7663.4 7690.7 7806.3 7537.9 7568.0 7684.0 7698.3 7731.2 6972.2 7042.2 7061.5 7067.3 7070.5 4645.1 5266.3 5334.3 5500.8 5578.7 5281.4 5324.3 5388.5 5389.8 5430.9 12:42:02 INFO - PROCESS | 9180 | 12:42:02 INFO - PROCESS | 9180 | [#4] prototype.html Cycles:180 Average:5582.85 Median:6345.49 stddev:1675.11 (26.4%) stddev-sans-first:1633.34 12:42:02 INFO - PROCESS | 9180 | Values: 362.4 363.9 365.3 370.4 373.2 6238.1 6319.1 6332.8 6334.9 6361.9 6227.7 6234.8 6237.9 6250.0 6250.9 4551.7 4660.5 4810.0 4812.0 4820.1 4765.6 4803.4 4807.6 4808.4 4814.6 4581.8 4784.8 4794.4 4794.7 4796.2 4632.5 4701.6 4705.1 4727.6 4750.5 4203.4 4218.5 4222.4 4226.0 4230.6 5964.4 5968.7 5974.3 5978.2 5982.6 5549.7 5570.3 5572.0 5574.1 5586.4 6440.9 6573.4 6578.7 6586.2 6588.3 4686.5 4701.7 4704.4 4705.7 4710.9 6831.4 6837.4 6850.5 6861.3 6863.1 4800.6 4806.6 4808.9 4809.5 4813.9 4871.0 4873.9 4874.0 4874.8 4876.4 5550.5 5556.0 5560.2 5565.2 5578.6 6462.3 6606.2 6649.6 6679.8 6692.5 1690.3 1707.5 1711.1 1714.2 1715.8 1093.7 1138.5 1153.4 1159.9 1171.9 6453.8 6568.6 6573.7 6578.2 6582.6 6902.8 6904.5 6910.9 6912.4 6914.2 6551.3 6552.2 6552.7 6554.9 6570.8 3668.8 3710.6 3711.2 3711.8 3713.9 7104.7 7249.2 7255.7 7256.9 7268.8 6967.5 6984.3 6995.2 7002.0 7002.5 7111.2 7113.6 7125.3 7131.5 7133.0 6884.9 6890.6 6892.3 6903.4 6909.3 6628.4 6773.1 6782.1 6788.5 6789.6 7210.2 7230.1 7235.2 7243.7 7245.0 4825.2 4834.9 4837.2 4841.2 4843.9 6841.9 6853.3 6858.5 6897.7 6932.2 6493.4 6641.0 6651.1 6654.2 6654.6 6609.8 6639.9 6640.3 6640.9 6642.3 6499.5 6500.5 6504.8 6505.9 6509.3 6672.4 6674.4 6685.0 6685.9 6707.5 6239.1 6334.5 6356.1 6508.8 6532.1 12:42:02 INFO - PROCESS | 9180 | 12:42:02 INFO - PROCESS | 9180 | [#5] yui.html Cycles:180 Average:15601.93 Median:4647.34 stddev:17737.49 (381.7%) stddev-sans-first:17752.58 12:42:02 INFO - PROCESS | 9180 | Values: 833.9 903.7 909.9 926.3 941.0 14577.9 14676.0 14705.5 14713.8 14812.8 13515.4 13577.5 13589.0 13592.9 13602.3 744.6 881.5 898.6 900.6 903.7 884.0 891.7 894.2 897.8 899.0 928.5 930.1 930.9 932.9 933.5 784.2 929.0 941.8 942.7 942.7 695.9 699.6 699.6 700.0 700.3 14854.7 14916.5 14919.7 14974.7 14979.6 14397.8 14897.7 14930.9 15039.2 15049.7 12492.1 12512.0 12549.2 12612.2 12773.1 4025.2 4044.8 4101.2 4119.4 4144.7 55622.7 55827.0 55851.4 55934.4 55964.0 11798.0 11858.9 11959.5 12066.5 12263.9 20917.9 21357.5 21375.0 21400.4 21403.7 7396.3 8282.2 8811.8 8932.2 9037.6 4874.1 4988.4 5005.4 5050.4 5086.7 3722.8 3748.4 3771.8 3772.4 3777.0 562.8 656.3 660.8 682.9 707.7 764.6 771.1 799.6 818.5 819.4 9813.0 10003.4 10365.6 10390.8 10549.3 757.7 760.8 764.3 818.3 823.8 4470.4 4560.7 4595.0 4699.7 4761.7 64279.7 64482.0 64633.4 64872.4 64885.0 53409.0 56108.4 56217.4 56622.7 56729.0 50944.0 51494.7 52210.0 52386.2 52463.5 9169.3 9186.9 9342.0 9358.6 9397.3 36409.3 36860.8 37552.0 38423.0 38622.4 47996.3 48167.8 48629.8 49554.3 49792.5 12887.5 12944.8 12990.3 13137.1 13389.3 13826.2 14210.5 14311.0 14510.2 14817.6 12970.7 13399.5 13402.5 13462.3 13941.6 13726.8 13769.6 13949.8 14197.6 14390.6 13464.2 13558.3 13571.0 13686.2 13741.5 9955.1 10162.1 10579.6 10599.5 10724.2 10982.7 11361.7 11491.3 11521.8 11576.5 12:42:02 INFO - PROCESS | 9180 | -------- Summary: end -------- 12:42:02 INFO - PROCESS | 9180 | 12:42:03 INFO - TEST-INFO | 9180: exit 0 12:42:03 INFO - TEST-OK | dromaeo_css | took 1111208ms 12:42:03 INFO - TEST-START | kraken 12:42:03 INFO - operating with platform_type : linux_ 12:42:03 INFO - Initialising browser for kraken test... 12:42:03 INFO - TEST-INFO | started process 9377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgYKR6v/profile http://localhost:45578/getInfo.html) 12:42:07 INFO - PROCESS | 9377 | __metrics Screen width/height:1600/1200 12:42:07 INFO - PROCESS | 9377 | colorDepth:24 12:42:07 INFO - PROCESS | 9377 | Browser inner width/height: 1024/697 12:42:07 INFO - PROCESS | 9377 | __metrics 12:42:08 ERROR - PROCESS | 9377 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:42:08 INFO - TEST-INFO | 9377: exit 0 12:42:08 INFO - Browser initialized. 12:42:08 INFO - Running cycle 1/1 for kraken test... 12:42:08 INFO - TEST-INFO | started process 9468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgYKR6v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:42:20 INFO - PROCESS | 9468 | RSS: Main: 140820480 12:42:20 INFO - PROCESS | 9468 | 12:42:23 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45578/tests/kraken/driver.html?testName=audio-beat-detection) 12:42:23 INFO - PROCESS | 9468 | RSS: Main: 197214208 12:42:23 INFO - PROCESS | 9468 | 12:42:26 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45578/tests/kraken/driver.html?testName=audio-dft) 12:42:27 INFO - PROCESS | 9468 | RSS: Main: 183787520 12:42:27 INFO - PROCESS | 9468 | 12:42:30 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45578/tests/kraken/driver.html?testName=audio-fft) 12:42:30 INFO - PROCESS | 9468 | RSS: Main: 272859136 12:42:30 INFO - PROCESS | 9468 | 12:42:32 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45578/tests/kraken/driver.html?testName=audio-oscillator) 12:42:33 INFO - PROCESS | 9468 | RSS: Main: 179556352 12:42:33 INFO - PROCESS | 9468 | 12:42:35 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45578/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:42:36 INFO - PROCESS | 9468 | RSS: Main: 177614848 12:42:36 INFO - PROCESS | 9468 | 12:42:39 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45578/tests/kraken/driver.html?testName=imaging-darkroom) 12:42:39 INFO - PROCESS | 9468 | RSS: Main: 212439040 12:42:39 INFO - PROCESS | 9468 | 12:42:42 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45578/tests/kraken/driver.html?testName=imaging-desaturate) 12:42:43 INFO - PROCESS | 9468 | RSS: Main: 211312640 12:42:43 INFO - PROCESS | 9468 | 12:42:46 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45578/tests/kraken/driver.html?testName=json-parse-financial) 12:42:46 INFO - PROCESS | 9468 | RSS: Main: 211529728 12:42:46 INFO - PROCESS | 9468 | 12:42:48 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45578/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:42:48 INFO - PROCESS | 9468 | RSS: Main: 191660032 12:42:48 INFO - PROCESS | 9468 | 12:42:50 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:42:51 INFO - PROCESS | 9468 | RSS: Main: 194805760 12:42:51 INFO - PROCESS | 9468 | 12:42:53 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:42:53 INFO - PROCESS | 9468 | RSS: Main: 211341312 12:42:53 INFO - PROCESS | 9468 | 12:42:56 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:42:56 INFO - PROCESS | 9468 | RSS: Main: 219017216 12:42:56 INFO - PROCESS | 9468 | 12:42:59 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:43:00 INFO - PROCESS | 9468 | RSS: Main: 214548480 12:43:00 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45578/tests/kraken/driver.html?testName=ai-astar) 12:43:02 INFO - PROCESS | 9468 | RSS: Main: 275124224 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | __start_tp_report 12:43:02 INFO - PROCESS | 9468 | _x_x_mozilla_page_load 12:43:02 INFO - PROCESS | 9468 | _x_x_mozilla_page_load_details 12:43:02 INFO - PROCESS | 9468 | |i|pagename|runs| 12:43:02 INFO - PROCESS | 9468 | |0;ai-astar;111;110;112;111;112;111;106;109;109;110 12:43:02 INFO - PROCESS | 9468 | |1;audio-beat-detection;163;134;157;179;135;163;160;127;183;126 12:43:02 INFO - PROCESS | 9468 | |2;audio-dft;162;161;162;161;161;161;161;162;161;161 12:43:02 INFO - PROCESS | 9468 | |3;audio-fft;77;75;76;167;75;76;76;73;168;75 12:43:02 INFO - PROCESS | 9468 | |4;audio-oscillator;92;94;151;91;92;92;145;91;92;154 12:43:02 INFO - PROCESS | 9468 | |5;imaging-gaussian-blur;117;118;116;116;117;116;118;116;117;117 12:43:02 INFO - PROCESS | 9468 | |6;imaging-darkroom;146;146;145;146;145;145;146;146;145;146 12:43:02 INFO - PROCESS | 9468 | |7;imaging-desaturate;95;95;95;95;96;95;95;94;95;94 12:43:02 INFO - PROCESS | 9468 | |8;json-parse-financial;54;55;54;54;54;55;57;73;54;53 12:43:02 INFO - PROCESS | 9468 | |9;json-stringify-tinderbox;58;59;58;59;59;62;58;59;59;59 12:43:02 INFO - PROCESS | 9468 | |10;stanford-crypto-aes;73;73;74;73;74;75;73;74;76;75 12:43:02 INFO - PROCESS | 9468 | |11;stanford-crypto-ccm;118;117;138;113;121;115;117;112;134;132 12:43:02 INFO - PROCESS | 9468 | |12;stanford-crypto-pbkdf2;164;164;171;165;169;166;168;165;166;164 12:43:02 INFO - PROCESS | 9468 | |13;stanford-crypto-sha256-iterative;67;68;68;69;67;66;67;67;68;67 12:43:02 INFO - PROCESS | 9468 | __end_tp_report 12:43:02 INFO - PROCESS | 9468 | __start_cc_report 12:43:02 INFO - PROCESS | 9468 | _x_x_mozilla_cycle_collect,1602 12:43:02 INFO - PROCESS | 9468 | __end_cc_report 12:43:02 INFO - PROCESS | 9468 | __startTimestamp1466019782255__endTimestamp 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | ------- Summary: start ------- 12:43:02 INFO - PROCESS | 9468 | Number of tests: 14 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.79 (1.6%) stddev-sans-first:1.87 12:43:02 INFO - PROCESS | 9468 | Values: 111.0 110.0 112.0 111.0 112.0 111.0 106.0 109.0 109.0 110.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:161.50 stddev:20.90 (12.9%) stddev-sans-first:21.83 12:43:02 INFO - PROCESS | 9468 | Values: 163.0 134.0 157.0 179.0 135.0 163.0 160.0 127.0 183.0 126.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 12:43:02 INFO - PROCESS | 9468 | Values: 162.0 161.0 162.0 161.0 161.0 161.0 161.0 162.0 161.0 161.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.50 stddev:38.86 (51.5%) stddev-sans-first:40.74 12:43:02 INFO - PROCESS | 9468 | Values: 77.0 75.0 76.0 167.0 75.0 76.0 76.0 73.0 168.0 75.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.00 stddev:28.11 (30.6%) stddev-sans-first:29.10 12:43:02 INFO - PROCESS | 9468 | Values: 92.0 94.0 151.0 91.0 92.0 92.0 145.0 91.0 92.0 154.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 12:43:02 INFO - PROCESS | 9468 | Values: 117.0 118.0 116.0 116.0 117.0 116.0 118.0 116.0 117.0 117.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:43:02 INFO - PROCESS | 9468 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:43:02 INFO - PROCESS | 9468 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 94.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:54.50 stddev:5.96 (10.9%) stddev-sans-first:6.27 12:43:02 INFO - PROCESS | 9468 | Values: 54.0 55.0 54.0 54.0 54.0 55.0 57.0 73.0 54.0 53.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:1.15 (2.0%) stddev-sans-first:1.17 12:43:02 INFO - PROCESS | 9468 | Values: 58.0 59.0 58.0 59.0 59.0 62.0 58.0 59.0 59.0 59.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:1.05 (1.4%) stddev-sans-first:1.05 12:43:02 INFO - PROCESS | 9468 | Values: 73.0 73.0 74.0 73.0 74.0 75.0 73.0 74.0 76.0 75.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:119.50 stddev:9.41 (7.9%) stddev-sans-first:9.88 12:43:02 INFO - PROCESS | 9468 | Values: 118.0 117.0 138.0 113.0 121.0 115.0 117.0 112.0 134.0 132.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.00 stddev:2.39 (1.4%) stddev-sans-first:2.40 12:43:02 INFO - PROCESS | 9468 | Values: 164.0 164.0 171.0 165.0 169.0 166.0 168.0 165.0 166.0 164.0 12:43:02 INFO - PROCESS | 9468 | 12:43:02 INFO - PROCESS | 9468 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 12:43:02 INFO - PROCESS | 9468 | Values: 67.0 68.0 68.0 69.0 67.0 66.0 67.0 67.0 68.0 67.0 12:43:02 INFO - PROCESS | 9468 | -------- Summary: end -------- 12:43:02 INFO - PROCESS | 9468 | 12:43:03 INFO - TEST-INFO | 9468: exit 0 12:43:03 INFO - TEST-OK | kraken | took 60022ms 12:43:03 INFO - SUITE-END | took 1171s 12:43:03 INFO - Completed test suite (00:19:31) 12:43:03 INFO - javascript benchmark 12:43:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3271.8691252349904, 3339.6994270515647, 3373.5445714828493, 3387.6612338766113, 3409.7783644063134, 5600.887982240348, 5604.775808967642, 5607.859803504914, 5608.327000759915, 5612.270404847374, 5587.469190426913, 5626.240457538231, 5626.943730562693, 5634.915476267849, 5643.5203007744285, 4986.252062190682, 5090.058339207249, 5144.56271216947, 5187.507186817265, 5234.26720259164, 5059.721715305656, 5097.260897169908, 5143.0485360208295, 5143.074246635604, 5148.716820574867, 5103.336566246383, 5122.154844450662, 5184.766685499161, 5219.947800521984, 5223.71269580173, 5175.197844334115, 5190.896182076337, 5203.167493201088, 5204.0372531081875, 5231.973840130775, 5007.0, 5008.799648014112, 5101.0, 5105.693658380509, 5113.744312784346, 5456.290682211326, 5486.890262194774, 5525.613207075507, 5532.004239236936, 5549.056660367747, 5936.584439089265, 5952.9107063394085, 5956.16613674086, 5968.134620480006, 5978.133170690226, 5983.670898100603, 5994.820155395345, 6053.697315134225, 6069.964484780226, 6084.178635884187, 5596.552275817925, 5626.324841019104, 5639.746211420496, 5639.915401268943, 5642.7178641067785, 5982.222311099529, 6140.754369825247, 6151.907721384183, 6155.661438620829, 6164.506839452833, 5842.591018628656, 5915.940840591625, 5919.970400147971, 5935.2877654681715, 5936.673482958392, 6018.458338749533, 6035.124906888476, 6035.6076855004285, 6036.094585812163, 6038.094285857069, 5816.563757718188, 5912.852178695567, 5986.341502434729, 6005.549583781234, 6010.098485227163, 5946.345901950782, 5953.672548009815, 5956.16613674086, 5958.970205149033, 5997.2803263607775, 4552.817887284537, 4558.817647294071, 4559.293309537027, 4560.201964656172, 4595.678302518859, 4025.6175663311938, 4031.7580945143386, 4068.5727998559723, 4075.5313138989395, 4115.97942010288, 5705.144228365778, 5731.0, 5734.39788822176, 5755.5683323750045, 5762.596618236767, 5975.701214939236, 6029.758809647653, 6033.879322413527, 6036.728347224385, 6040.124181993674, 5656.660600363992, 5748.655080695172, 5753.827385178452, 5808.186853840466, 5817.912731309034, 5079.6698214615935, 5089.949100508948, 5091.821786237464, 5096.541311282002, 5097.949020509747, 6315.936840631535, 6319.96840015797, 6320.968395158086, 6325.304216536178, 6326.841828954221, 5887.499562537147, 5990.820275391745, 6046.818595442144, 6124.0201567748945, 6124.755009799558, 6225.844353891008, 6229.247440103246, 6266.060090986389, 6268.310485846644, 6287.119803227461, 5713.057345538106, 5885.087811389241, 5885.823425297248, 5891.3224979127945, 5926.703664816656, 5864.882702346014, 5937.228160339128, 5944.851378715567, 5946.0, 5989.071693887455, 5821.359650438533, 5867.295924489089, 5871.559633027455, 5871.559633027626, 5878.941210587839, 5734.5125664319, 5826.854328641648, 5838.095095260242, 5875.265591801025, 5893.852653683693, 5723.513501352265, 5783.739731712168, 5788.652680839163, 5802.7098645066735, 5827.621204621686, 5940.16837642739, 5947.851303717442, 5950.642961422329, 5958.34458209588, 5961.433663801932, 5614.157876318585, 5781.988152073286, 5826.329972053099, 5857.58996870232, 5876.294844618673], "value": 5542.048426927061, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.7584793626359, 675.9455249810295, 677.1231255524095, 729.5294535024909, 744.7914583916505, 31825.0, 32341.0, 32363.838180809093, 39784.0, 40532.39201411981, 42838.0, 43222.78388608061, 43443.78278108605, 43488.56511434885, 43557.0, 7935.523868567876, 8708.21626053655, 8890.199882010618, 8897.332700047522, 8899.510526921016, 10604.257701960865, 10979.2863463875, 10982.835257471144, 10984.670459886216, 10994.560217591286, 10687.0, 10738.677839664822, 10747.677569672922, 10748.0, 10752.462376881163, 10539.947300263488, 10608.946955265252, 10634.415107169103, 10643.414612196326, 10646.095081918047, 10406.531706073245, 10490.475476226235, 10506.78986420275, 10515.106215971651, 10523.368597884151, 42791.78604106991, 43295.35056974148, 43298.56701432977, 43341.349879751826, 43456.130877382595, 3584.444411116281, 3656.8354424050717, 3658.140337020798, 3888.7083468739675, 4220.725652832556, 31468.842655786575, 32543.349133017444, 32600.0, 32647.183820404443, 32730.345393092004, 4469.128519938613, 4581.3128030795315, 4586.3579098926175, 4587.839425620121, 4600.677952543323, 328506.0, 330215.0, 331043.0, 332257.0, 333425.99999999756, 39686.60313396829, 63003.36996629975, 63408.36591634117, 63596.0, 63711.36288637147, 38107.809460952514, 38161.42757858634, 38418.231635367134, 38421.807890960925, 38504.229915402095, 17002.404915827887, 17163.656726865393, 17171.227294771765, 17205.82794172042, 17227.39704110375, 12596.181248218836, 13450.730985380238, 13458.52895148665, 13477.663058423423, 14957.177355245565, 9380.812383752424, 9384.67153649619, 9412.435253884789, 9487.193588544913, 9487.241020718326, 3594.5686517617532, 3691.0, 3734.9626503734617, 3736.23407201523, 3769.095417099931, 1108.8336749487642, 1118.9690711358858, 1138.1236447935044, 1154.215133709069, 1176.8764279750503, 32742.67257327396, 33596.83201584026, 34017.82991085029, 34147.0, 34680.65319346825, 1122.5734220996133, 1150.0512077536066, 1191.1602320364123, 1239.0149830884468, 1249.4002878618314, 15327.46353877609, 16137.193140342935, 16233.51299461018, 16589.751153732705, 16745.916270418813, 439014.0, 444189.0, 446425.0, 446496.0, 446501.0, 61248.387516125156, 61821.0, 61900.0, 61947.0, 61984.69007655023, 1320.491610729876, 1415.6036309833057, 1423.939165321821, 1499.2428823444309, 1613.6207991122078, 30091.247718807204, 31015.68984310128, 33349.666503335626, 33558.832205838815, 34120.48819267663, 52597.47402525926, 53380.46619533755, 53439.0, 53539.46460535501, 53568.73215633897, 359344.0, 361398.0, 361742.0, 361948.0, 362946.0, 29909.401811964075, 31231.687683122876, 31241.843790780902, 31274.0, 31274.843625781727, 51059.2341114891, 51480.22779658233, 51583.742081289354, 52441.0, 53239.733801330745, 41803.58196417997, 41945.0, 42490.78754606207, 42524.362134568626, 43421.348679769195, 40173.799131004154, 41243.0, 42333.0, 42338.57661423346, 42623.0, 43179.35230971601, 43891.34162987622, 44303.556964431235, 44386.334204987594, 44890.63320250929, 36982.44526332161, 37948.62051379451, 38349.0, 38498.61501385062, 38499.615003849605, 28895.133146005654, 29627.555586665785, 29833.55249671213, 29873.551896722, 29891.55162672605], "value": 19789.751273677844, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.60897147709676, 433.14237809137927, 434.5458995349861, 442.48008589906857, 449.39331901932394, 18439.446816595508, 18508.537286567844, 18956.431307060793, 19102.808971910275, 19277.132529036193, 19777.307794227207, 19817.207311707516, 20507.589848203028, 20548.589028219427, 20579.27972520962, 5712.22884910536, 5760.999999999989, 5966.284045914496, 5972.79095231667, 5984.611000284967, 4288.078063216408, 5852.970735146339, 5922.763089476437, 6166.84582885427, 6467.773627923024, 6440.80677579671, 6443.452306553949, 6456.806295811133, 6457.612543247396, 6457.773977910774, 5460.754266058037, 5745.798897038583, 5747.2241247431475, 5751.827445176651, 6402.13571167891, 3866.3620502617036, 5462.5083742462975, 5619.775208991636, 5638.774449022034, 5685.516731077863, 13283.3358332083, 13940.37268322928, 14017.369218385094, 14067.507637232648, 14159.150450972975, 2273.8654224699135, 2327.2087490253393, 2332.9035353383883, 2451.681281433402, 2900.1734505665995, 9970.551325190383, 10625.096866766256, 10648.0, 12671.683207919783, 14541.691247787645, 1943.630710165064, 1957.3736404350614, 1991.5220347116588, 2039.428959891218, 2055.804698553635, 71995.0, 73728.63135684341, 75874.0, 77852.22147778506, 80766.59616701938, 11288.322700637988, 11394.487248073856, 11472.88527114718, 11605.245659032305, 11833.408329583486, 16178.67642647164, 16275.837241627669, 16368.918155409146, 16369.42707005249, 16408.09755463461, 8900.243479304203, 8901.421407608485, 8936.195742383086, 8969.865452018224, 8974.955125224333, 8685.609147588373, 8709.869351959725, 8760.430572012927, 8816.735497935073, 8853.937527496613, 5022.347094877716, 5060.822871199564, 5073.518015788494, 5116.155834287375, 5124.5131712487255, 1816.1281253236796, 1943.7667479902502, 1963.448875388427, 2000.1999200319697, 2025.9493512662007, 975.4342481360794, 1021.8569400283966, 1028.290479569095, 1071.1591400750374, 1114.7380365614074, 17571.648567028587, 17816.643667126584, 17885.10574471297, 19477.610447790965, 19763.0, 1078.094400703413, 1091.5906535049357, 1103.1450625765096, 1105.2263415609107, 1132.2017977325966, 10373.273870828969, 10797.082248009006, 10877.23859329855, 10891.128709703205, 10934.234603577674, 385791.0, 388557.0, 551955.0, 560685.0, 570444.0, 86450.56774716087, 88405.0, 99915.50042249743, 102338.0, 104189.47905260425, 1087.6410784441116, 1119.468252580018, 1126.391748455841, 1127.205320249206, 1129.2377645089696, 16552.42066527666, 16942.40701575439, 16981.915090424467, 17488.91255543765, 17843.73234401511, 36466.0, 36699.08252293714, 40513.39229911612, 41300.173996520505, 41362.172756544096, 50359.74820125876, 51830.48169518256, 52499.73750131225, 56912.43087569237, 57258.427415726976, 8963.0, 9030.0, 9056.547172641473, 9160.221381182673, 9265.397749146285, 10207.693769186937, 12678.175918565265, 13338.466461341826, 13552.186868787905, 14150.221737804519, 11995.460204291003, 12085.274883507018, 12138.089643276613, 12180.086493512845, 12384.81422778641, 11750.47243858293, 11927.165098443025, 11955.820662690241, 12177.147599667938, 12315.076369272161, 11820.349880756641, 11823.231489953125, 12206.32865192423, 12292.323922184365, 12376.566820161252, 9162.404443711137, 9188.0, 9239.584218710308, 9240.0, 9412.576434060347, 9084.954575227082, 11771.176017678681, 11915.790946477602, 11970.281783092694, 12001.63995080149], "value": 9361.585271267077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.410567561624, 1608.7667288243204, 1649.1918959709747, 1868.8603146713515, 1985.8892093366737, 7667.616619169047, 8313.168683131684, 8465.957670211656, 8507.702230421937, 8519.95740021299, 8375.664973401072, 8518.574071296425, 8554.101819308977, 8566.05773364931, 8572.871406928902, 2455.287966489716, 2468.568000599888, 2474.715407728116, 2474.826762126652, 2477.4549599088173, 2407.0492155598527, 2422.0432928993037, 2431.586630272849, 2434.196715084027, 2461.4215659320043, 2319.1535089692225, 2353.8234632402555, 2353.9058437662475, 2359.304005318435, 2379.6311571706415, 2434.805215582749, 2458.0659349447274, 2459.2007597530783, 2466.851988880655, 2467.864267465289, 2402.0631953538136, 2437.512497500507, 2448.424620214248, 2449.64480150379, 2451.178855083549, 7473.476856620039, 7628.847423051563, 8714.912850871473, 8768.649254029831, 8786.956065219696, 5342.973285133588, 5432.266644003049, 5437.211604317352, 5487.067198576252, 5489.6980666063355, 3503.91240218994, 3536.469529570559, 3611.674949254553, 3618.0412190769466, 3655.689266412358, 1147.736020715232, 1162.9651110466616, 1166.212806355715, 1190.6309044196241, 1205.7106294489347, 11812.881871181264, 11910.225835320676, 11925.284482931052, 12262.38688065602, 12305.077119216005, 4898.951010489921, 4936.827211047596, 4977.626677999092, 4983.626228032912, 4994.850154495371, 10437.843432348522, 10446.895531044744, 10474.795398529115, 10512.21158413122, 10527.473626318653, 5535.501804837584, 5536.557075433956, 5545.72271386429, 5545.861353466195, 5546.4453554644215, 4988.0, 5000.524950129732, 5055.51972562606, 5062.443131255559, 5064.442911279756, 4027.5368332641533, 4081.0, 4122.464079669624, 4123.546409894969, 4131.669466442678, 1344.0793056756154, 1347.6388847264334, 1352.371147416456, 1367.7811550151928, 1373.1417863835104, 1061.4692653673164, 1069.315637991686, 1075.8977897099762, 1081.789051135021, 1092.4428541443922, 5938.851528711817, 6045.063015232646, 6136.509079273647, 6154.415330543681, 6231.22109736283, 494.76004137993044, 502.8189851653475, 508.1995856525912, 516.6254465512474, 524.7114087251996, 4076.408920706481, 4094.61101195386, 4180.122174343422, 4207.305794543927, 4224.471941007374, 10385.169186465064, 10829.025387715143, 10840.67477975662, 10844.349339039525, 10874.347539147677, 10488.63289784869, 10646.893531064745, 10658.360498370123, 10661.573537058586, 10675.412852293199, 8252.092269850311, 8259.545724985064, 8284.917150828414, 8321.04308004575, 8335.45819521717, 5830.18377427169, 5917.28992520883, 5930.673812940157, 5933.436323549256, 6074.3318234994995, 9415.482148481899, 9528.428294302365, 9536.761580960532, 9607.423554586747, 9709.563069662023, 9501.809963800824, 9808.0, 9867.753306167404, 9890.406575605486, 10090.949545252226, 7521.285477879593, 7541.35898448638, 7565.054368203974, 7612.0, 7690.923090769021, 8283.875741863998, 8397.118302578141, 8401.915980840113, 8404.285635720787, 8431.620577074169, 7499.812504687208, 7620.657070431955, 7663.386929045774, 7690.653920573475, 7806.297433231037, 7537.924620753723, 7567.962160189384, 7684.0, 7698.307152356315, 7731.188225236269, 6972.233054363915, 7042.154941407064, 7061.505694601534, 7067.293270673097, 7070.540414873017, 4645.140648979949, 5266.315379000705, 5334.253204551444, 5500.834974950758, 5578.748956297058, 5281.419043905091, 5324.345253459832, 5388.488093631099, 5389.8113566025, 5430.918536222039], "value": 4644.517307750784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.39841862508234, 363.86900715742325, 365.25123496831486, 370.3592784482843, 373.2479054704769, 6238.0642903564485, 6319.05214217867, 6332.810015699531, 6334.904976425358, 6361.9045714314325, 6227.719752611143, 6234.84412889678, 6237.906431403532, 6249.968750156243, 6250.874982500359, 4551.726896386219, 4660.464046634646, 4809.951900480985, 4811.975940120295, 4820.132376172288, 4765.594924431428, 4803.351547541072, 4807.61539076873, 4808.374911261531, 4814.590759785422, 4581.839635612754, 4784.784684689197, 4794.448638406593, 4794.712317260958, 4796.160671882424, 4632.536746325374, 4701.576858082754, 4705.058988202373, 4727.621790256771, 4750.477447480775, 4203.4115223868685, 4218.493780746299, 4222.4299719538085, 4226.049138943744, 4230.603900712757, 5964.373740757202, 5968.7015649217365, 5974.312954010257, 5978.163057172, 5982.611130276518, 5549.667019978774, 5570.3315602127595, 5572.0, 5574.108142697149, 5586.35756887959, 6440.871182576369, 6573.375529324707, 6578.671066446658, 6586.176727909012, 6588.341165883421, 4686.53134686532, 4701.7414042227665, 4704.364910737041, 4705.694129881546, 4710.905781884378, 6831.419329357011, 6837.35045170708, 6850.45196384293, 6861.348171923659, 6863.10779598654, 4800.639952003614, 4806.567408933212, 4808.903821923612, 4809.470958194665, 4813.855584332476, 4870.951290487121, 4873.926891096637, 4874.025194961022, 4874.8050077997195, 4876.366072410635, 5550.500454959073, 5555.97207019435, 5560.221568980346, 5565.248691426606, 5578.609497335228, 6462.256840463407, 6606.240282367589, 6649.601023938482, 6679.833004174934, 6692.531522793358, 1690.3407671008317, 1707.5304291319987, 1711.076018949778, 1714.2371644618274, 1715.836995485427, 1093.6554985179644, 1138.499060413432, 1153.371412580146, 1159.8840115988503, 1171.8593768747635, 6453.838654033687, 6568.6058836469965, 6573.671316434255, 6578.243501997332, 6582.605043697394, 6902.827429314207, 6904.516683832184, 6910.896336554955, 6912.447004239649, 6914.239433662293, 6551.279359270477, 6552.213734351813, 6552.705128269239, 6554.868902622016, 6570.8357291068105, 3668.779873207616, 3710.6474884885893, 3711.2391959648207, 3711.777293362353, 3713.9257214856093, 7104.680289386886, 7249.166345870187, 7255.673494692752, 7256.9274307256255, 7268.781936541912, 6967.512274140863, 6984.266652001466, 6995.1955525114245, 7001.964990175016, 7002.474814388941, 7111.217766045731, 7113.64431778409, 7125.251848555827, 7131.536450130829, 7133.0013798067275, 6884.862302753817, 6890.552114112566, 6892.310768923067, 6903.447724181953, 6909.343612356818, 6628.370304821035, 6773.119494465885, 6782.084418603426, 6788.49086318538, 6789.592624442549, 7210.242924493063, 7230.13238411394, 7235.167955685163, 7243.710251589878, 7244.963775181091, 4825.203841366135, 4834.927476087792, 4837.2260438329695, 4841.225403935354, 4843.941324936958, 6841.897371539331, 6853.314668533306, 6858.451323894176, 6897.655117244218, 6932.23745388017, 6493.383128602775, 6640.966795165993, 6651.135352404156, 6654.201495820533, 6654.567453115532, 6609.834754131185, 6639.933600663931, 6640.302768209269, 6640.867182656223, 6642.3025582315095, 6499.4800415965665, 6500.5449618526245, 6504.772332968323, 6505.8698826024165, 6509.349065093453, 6672.366125218096, 6674.399304062657, 6684.9972504122825, 6685.8997115044285, 6707.463402927851, 6239.126522286974, 6334.524910631629, 6356.078368636614, 6508.837279067871, 6532.05285233629], "value": 5043.476583805076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.9291160251378, 903.7062954539776, 909.8953620333659, 926.2543652359848, 940.9905900940993, 14577.854221457783, 14676.0, 14705.485308014222, 14713.779293310608, 14812.77780833287, 13515.391807368667, 13577.524786632444, 13589.0, 13592.932035339834, 13602.319884005785, 744.601638123604, 881.5371929736875, 898.5552151684925, 900.5857305639381, 903.7062954539768, 884.0496466298722, 891.7413949954505, 894.1639567004838, 897.8024834536392, 899.0110878034143, 928.5496534180917, 930.1117432851644, 930.9348345615809, 932.9440233586007, 933.54722959365, 784.2236186175702, 929.0338048429625, 941.7598512379368, 942.6606421688186, 942.6936245720134, 695.9443244540475, 699.5557820783788, 699.576756062585, 700.0444393402968, 700.3346820520526, 14854.70290594182, 14916.477923272741, 14919.701605967819, 14974.700505989927, 14979.625509362244, 14397.78403323951, 14897.70204595902, 14930.925345373313, 15039.172845493493, 15049.699006019928, 12492.063095267891, 12512.0, 12549.184303020274, 12612.180208286432, 12773.105882588223, 4025.1547175093265, 4044.776119402985, 4101.179764047202, 4119.402686610425, 4144.689148313858, 55622.72188639071, 55827.0, 55851.441485585034, 55934.44065559333, 55964.0, 11798.0, 11858.881411185777, 11959.521619135312, 12066.517339306505, 12263.93868030654, 20917.89541052285, 21357.46606334854, 21375.03812328449, 21400.35798926035, 21403.67894481584, 7396.260373962561, 8282.17178282179, 8811.823763524693, 8932.151445612657, 9037.59917212833, 4874.122657921608, 4988.401391833003, 5005.424376196711, 5050.419201791841, 5086.669366491166, 3722.7766334020043, 3748.437734339871, 3771.7548359356556, 3772.43413487979, 3777.036855601804, 562.7833284185537, 656.3043174235326, 660.7555204574338, 682.9009793580002, 707.7204504220804, 764.636797521173, 771.1401787007446, 799.6321692021735, 818.4720855048461, 819.4223072733828, 9812.950935245279, 10003.449810260505, 10365.585376584851, 10390.844137337946, 10549.314294570828, 757.6817736550662, 760.8364201696662, 764.2701220334567, 818.2880893622468, 823.7693445835175, 4470.374147619336, 4560.657950653715, 4594.95405045952, 4699.718016918996, 4761.666683332202, 64279.67860160763, 64482.0, 64633.35366646273, 64872.35127648758, 64885.02672459917, 53409.0, 56108.438915611136, 56217.43782562204, 56622.71688641613, 56729.0, 50944.0, 51494.742526287126, 52210.0, 52386.21420678693, 52463.47536524586, 9169.312301577274, 9186.908130918606, 9341.953290233505, 9358.578863951003, 9397.342186046912, 36409.27181456409, 36860.81569592135, 37552.0, 38423.0, 38622.42066369063, 47996.28005579989, 48167.75916120397, 48629.75685121552, 49554.25668614901, 49792.50207497879, 12887.548935787203, 12944.8058279124, 12990.285534295705, 13137.146085504412, 13389.263590502616, 13826.239556824472, 14210.502632407815, 14311.0, 14510.201938893462, 14817.629559261104, 12970.675733106747, 13399.53101641438, 13402.463901443833, 13462.326883655582, 13941.58175254744, 13726.794098088736, 13769.586912392644, 13949.790753138508, 14197.645058873612, 14390.568282951528, 13464.192148471124, 13558.254296013814, 13571.0, 13686.178829270275, 13741.519046833313, 9955.104040636377, 10162.136218421221, 10579.62971296001, 10599.470026498799, 10724.249302548747, 10982.725431864268, 11361.715957101138, 11491.310521368745, 11521.82717259225, 11576.47905844256], "value": 7206.102536223063, "unit": "score"}], "name": "dromaeo_css", "value": 7466.976435409052, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 112.0, 111.0, 112.0, 111.0, 106.0, 109.0, 109.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 134.0, 157.0, 179.0, 135.0, 163.0, 160.0, 127.0, 183.0, 126.0], "value": 152.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 167.0, 75.0, 76.0, 76.0, 73.0, 168.0, 75.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 151.0, 91.0, 92.0, 92.0, 145.0, 91.0, 92.0, 154.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 116.0, 117.0, 116.0, 118.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 57.0, 73.0, 54.0, 53.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 62.0, 58.0, 59.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 73.0, 74.0, 75.0, 73.0, 74.0, 76.0, 75.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 138.0, 113.0, 121.0, 115.0, 117.0, 112.0, 134.0, 132.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 171.0, 165.0, 169.0, 166.0, 168.0, 165.0, 166.0, 164.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 69.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1529.2, "alertThreshold": 2.0}]} 12:43:03 INFO - Return code: 0 12:43:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:43:03 ERROR - # TBPL SUCCESS # 12:43:03 INFO - Running post-action listener: _resource_record_post_action 12:43:03 INFO - Running post-run listener: _resource_record_post_run 12:43:04 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 333017088; Read time: 4; Write time: 170560 12:43:04 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 110678016; Read time: 0; Write time: 80436 12:43:04 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222339072; Read time: 4; Write time: 90124 12:43:04 INFO - Running post-run listener: _upload_blobber_files 12:43:04 INFO - Blob upload gear active. 12:43:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:43:04 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 12:43:04 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:43:04 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:43:05 INFO - (blobuploader) - INFO - Open directory for files ... 12:43:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:43:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:43:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:05 INFO - (blobuploader) - INFO - Done attempting. 12:43:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:43:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:06 INFO - (blobuploader) - INFO - Done attempting. 12:43:06 INFO - (blobuploader) - INFO - Iteration through files over. 12:43:06 INFO - Return code: 0 12:43:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:43:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:43:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f562346e3fba63f85538ecc426943dff8d05133206a35f51cb9a2bce5ba5db2baaa0a40003cd54c0a78b8c8a0eba842cbc71e3f05136b4fab30e85a07348283b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b93e63f7d422a585db49d1352a990775453f10912f86919502c0f523f645f44625b8e0a28f4047e6a364e86e9ef16fd1c049d5a002ea6987ff1f81df0dbc547e"} 12:43:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:43:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:43:06 INFO - Contents: 12:43:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f562346e3fba63f85538ecc426943dff8d05133206a35f51cb9a2bce5ba5db2baaa0a40003cd54c0a78b8c8a0eba842cbc71e3f05136b4fab30e85a07348283b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b93e63f7d422a585db49d1352a990775453f10912f86919502c0f523f645f44625b8e0a28f4047e6a364e86e9ef16fd1c049d5a002ea6987ff1f81df0dbc547e"} 12:43:06 INFO - Running post-run listener: copy_logs_to_upload_dir 12:43:06 INFO - Copying logs to upload dir... 12:43:06 INFO - mkdir: /builds/slave/test/build/upload/logs 12:43:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.985856 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-15 12:43:06.428104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 12:43:06.432005) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f562346e3fba63f85538ecc426943dff8d05133206a35f51cb9a2bce5ba5db2baaa0a40003cd54c0a78b8c8a0eba842cbc71e3f05136b4fab30e85a07348283b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b93e63f7d422a585db49d1352a990775453f10912f86919502c0f523f645f44625b8e0a28f4047e6a364e86e9ef16fd1c049d5a002ea6987ff1f81df0dbc547e"} build_url:https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/QCRCn4rQSNaPHOnxQEyKUA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f562346e3fba63f85538ecc426943dff8d05133206a35f51cb9a2bce5ba5db2baaa0a40003cd54c0a78b8c8a0eba842cbc71e3f05136b4fab30e85a07348283b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b93e63f7d422a585db49d1352a990775453f10912f86919502c0f523f645f44625b8e0a28f4047e6a364e86e9ef16fd1c049d5a002ea6987ff1f81df0dbc547e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 12:43:06.457784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 12:43:06.458133) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466016021.199210-876490335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 12:43:06.545207) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 12:43:06.545577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 12:43:06.545894) ========= ========= Total master_lag: 0.17 =========