builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1465814607.21 results: success (0) buildid: 20160613005526 builduid: 6a95dfcdeac04de68e5679106afb4404 revision: 2539cf53e85d348397cdee353061a34e8b0f11fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:27.208476) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:27.209202) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:27.209702) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:27.227686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:27.227974) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 03:43:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-06-13 03:43:27 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070344 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:27.312290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:27.312670) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018195 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:27.362104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:27.362427) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2539cf53e85d348397cdee353061a34e8b0f11fb --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 2539cf53e85d348397cdee353061a34e8b0f11fb --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=e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 03:43:27,903 truncating revision to first 12 chars 2016-06-13 03:43:27,903 Setting DEBUG logging. 2016-06-13 03:43:27,903 attempt 1/10 2016-06-13 03:43:27,903 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2539cf53e85d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 03:43:28,251 unpacking tar archive at: mozilla-beta-2539cf53e85d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:28.050902) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:28.051199) ========= script_repo_revision: 2539cf53e85d348397cdee353061a34e8b0f11fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:28.051592) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:28.051853) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 03:43:28.059950) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-13 03:43:28.060216) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:43:28 INFO - MultiFileLogger online at 20160613 03:43:28 in /builds/slave/test 03:43:28 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 03:43:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:28 INFO - {'append_to_log': False, 03:43:28 INFO - 'base_work_dir': '/builds/slave/test', 03:43:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:43:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:28 INFO - 'branch': 'Mozilla-Beta', 03:43:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:28 INFO - 'config_files': ('talos/linux_config.py',), 03:43:28 INFO - 'default_actions': ('clobber', 03:43:28 INFO - 'read-buildbot-config', 03:43:28 INFO - 'download-and-extract', 03:43:28 INFO - 'populate-webroot', 03:43:28 INFO - 'create-virtualenv', 03:43:28 INFO - 'install', 03:43:28 INFO - 'run-tests'), 03:43:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:28 INFO - 'download_minidump_stackwalk': True, 03:43:28 INFO - 'download_symbols': 'ondemand', 03:43:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:43:28 INFO - 'tooltool.py': '/tools/tooltool.py', 03:43:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:43:28 INFO - '/tools/misc-python/virtualenv.py')}, 03:43:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:28 INFO - 'installer_path': 'installer.exe', 03:43:28 INFO - 'log_level': 'info', 03:43:28 INFO - 'log_name': 'talos', 03:43:28 INFO - 'log_to_console': True, 03:43:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:43:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:43:28 INFO - 'opt_config_files': (), 03:43:28 INFO - 'pip_index': False, 03:43:28 INFO - 'sps_profile': False, 03:43:28 INFO - 'sps_profile_interval': 0, 03:43:28 INFO - 'suite': 'dromaeojs', 03:43:28 INFO - 'system_bits': '32', 03:43:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:28 INFO - 'title': 'talos-linux64-ix-067', 03:43:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:28 INFO - 'use_talos_json': True, 03:43:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:28 INFO - 'work_dir': 'build'} 03:43:28 INFO - ##### 03:43:28 INFO - ##### Running clobber step. 03:43:28 INFO - ##### 03:43:28 INFO - Running pre-action listener: _resource_record_pre_action 03:43:28 INFO - Running main action method: clobber 03:43:28 INFO - rmtree: /builds/slave/test/build 03:43:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:29 INFO - Running post-action listener: _resource_record_post_action 03:43:29 INFO - ##### 03:43:29 INFO - ##### Running read-buildbot-config step. 03:43:29 INFO - ##### 03:43:29 INFO - Running pre-action listener: _resource_record_pre_action 03:43:29 INFO - Running main action method: read_buildbot_config 03:43:29 INFO - Using buildbot properties: 03:43:29 INFO - { 03:43:29 INFO - "project": "", 03:43:29 INFO - "product": "firefox", 03:43:29 INFO - "script_repo_revision": "production", 03:43:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 03:43:29 INFO - "repository": "", 03:43:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 03:43:29 INFO - "buildid": "20160613005526", 03:43:29 INFO - "pgo_build": "True", 03:43:29 INFO - "basedir": "/builds/slave/test", 03:43:29 INFO - "buildnumber": 269, 03:43:29 INFO - "slavename": "talos-linux64-ix-067", 03:43:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:43:29 INFO - "platform": "ubuntu64_hw", 03:43:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:43:29 INFO - "branch": "mozilla-beta", 03:43:29 INFO - "repo_path": "releases/mozilla-beta", 03:43:29 INFO - "revision": "2539cf53e85d348397cdee353061a34e8b0f11fb", 03:43:29 INFO - "stage_platform": "linux64-pgo", 03:43:29 INFO - "builduid": "6a95dfcdeac04de68e5679106afb4404", 03:43:29 INFO - "slavebuilddir": "test" 03:43:29 INFO - } 03:43:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 03:43:29 INFO - Running post-action listener: _resource_record_post_action 03:43:29 INFO - ##### 03:43:29 INFO - ##### Running download-and-extract step. 03:43:29 INFO - ##### 03:43:29 INFO - Running pre-action listener: _resource_record_pre_action 03:43:29 INFO - Running main action method: download_and_extract 03:43:29 INFO - mkdir: /builds/slave/test/build/tests 03:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:29 INFO - https://queue.taskcluster.net/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:43:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:43:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:43:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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 03:43:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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 03:43:30 INFO - Downloaded 1327 bytes. 03:43:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:43:30 INFO - Using the following test package requirements: 03:43:30 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:43:30 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:43:30 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:43:30 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:43:30 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 03:43:30 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:43:30 INFO - u'jsshell-linux-x86_64.zip'], 03:43:30 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:43:30 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:43:30 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:43:30 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:43:30 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 03:43:30 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:43:30 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 03:43:30 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:43:30 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:43:30 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:43:30 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:43:30 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:43: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')]} 03:43:30 INFO - https://queue.taskcluster.net/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:43:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:43:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:43:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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 03:43:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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 03:43:32 INFO - Downloaded 24178153 bytes. 03:43:32 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'] 03:43:32 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 03:43:33 INFO - Return code: 0 03:43:33 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 03:43: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')]} 03:43:33 INFO - https://queue.taskcluster.net/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:43:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:43:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:43:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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 03:43:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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 03:43:36 INFO - Downloaded 24178153 bytes. 03:43: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'] 03:43: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 03:43:38 INFO - Return code: 0 03:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:38 INFO - https://queue.taskcluster.net/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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 03:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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 03:43:39 INFO - Downloaded 10840145 bytes. 03:43:39 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'] 03:43:39 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 03:43:39 INFO - Return code: 0 03:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:39 INFO - https://queue.taskcluster.net/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:43:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:43:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:43:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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 03:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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 03:43:41 INFO - Downloaded 55992617 bytes. 03:43:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:43:41 INFO - mkdir: /builds/slave/test/properties 03:43:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:43:41 INFO - Writing to file /builds/slave/test/properties/build_url 03:43:41 INFO - Contents: 03:43:41 INFO - build_url:https://queue.taskcluster.net/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:43:41 INFO - Running post-action listener: _resource_record_post_action 03:43:41 INFO - Running post-action listener: set_extra_try_arguments 03:43:41 INFO - ##### 03:43:41 INFO - ##### Running populate-webroot step. 03:43:41 INFO - ##### 03:43:41 INFO - Running pre-action listener: _resource_record_pre_action 03:43:41 INFO - Running main action method: populate_webroot 03:43:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:43:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:43:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:43:41 INFO - '--tppagecycles', 03:43:41 INFO - '7'], 03:43:41 INFO - 'tests': ['tsvgm']}}, 03:43:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:43:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:43:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:43:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:43:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:43:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:43:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:41 INFO - 'talos_options': ['--disable-e10s'], 03:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:41 INFO - 'talos_options': ['--disable-e10s'], 03:43:41 INFO - 'tests': ['damp', 'tps']}, 03:43:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:41 INFO - 'tests': ['damp', 'tps']}, 03:43:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:43:41 INFO - 'tests': ['dromaeo_dom']}, 03:43:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:43:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:43:41 INFO - 'tests': ['a11yr', 03:43:41 INFO - 'ts_paint', 03:43:41 INFO - 'tpaint', 03:43:41 INFO - 'sessionrestore', 03:43:41 INFO - 'sessionrestore_no_auto_restore', 03:43:41 INFO - 'tabpaint']}, 03:43:41 INFO - 'other-e10s': {'tests': ['a11yr', 03:43:41 INFO - 'ts_paint', 03:43:41 INFO - 'tpaint', 03:43:41 INFO - 'sessionrestore', 03:43:41 INFO - 'sessionrestore_no_auto_restore', 03:43:41 INFO - 'tabpaint']}, 03:43:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:43:41 INFO - 'ts_paint', 03:43:41 INFO - 'tpaint', 03:43:41 INFO - 'sessionrestore', 03:43:41 INFO - 'sessionrestore_no_auto_restore', 03:43:41 INFO - 'tabpaint']}, 03:43:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:43:41 INFO - 'ts_paint', 03:43:41 INFO - 'tpaint', 03:43:41 INFO - 'sessionrestore', 03:43:41 INFO - 'sessionrestore_no_auto_restore', 03:43:41 INFO - 'tabpaint']}, 03:43:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:43:41 INFO - 'tests': ['a11yr', 03:43:41 INFO - 'ts_paint', 03:43:41 INFO - 'tpaint', 03:43:41 INFO - 'sessionrestore', 03:43:41 INFO - 'sessionrestore_no_auto_restore', 03:43:41 INFO - 'tabpaint']}, 03:43:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:43:41 INFO - 'tests': ['a11yr', 03:43:41 INFO - 'ts_paint', 03:43:41 INFO - 'tpaint', 03:43:41 INFO - 'sessionrestore', 03:43:41 INFO - 'sessionrestore_no_auto_restore', 03:43:41 INFO - 'tabpaint']}, 03:43:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:43:41 INFO - 'tests': ['tsvgx', 03:43:41 INFO - 'tsvgr_opacity', 03:43:41 INFO - 'tart', 03:43:41 INFO - 'tscrollx', 03:43:41 INFO - 'cart']}, 03:43:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:43:41 INFO - 'tsvgr_opacity', 03:43:41 INFO - 'tart', 03:43:41 INFO - 'tscrollx', 03:43:41 INFO - 'cart']}, 03:43:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:41 INFO - 'talos_options': ['--disable-e10s'], 03:43:41 INFO - 'tests': ['tp5o']}, 03:43:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:41 INFO - 'tests': ['tp5o']}, 03:43:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:41 INFO - 'talos_options': ['--disable-e10s', 03:43:41 INFO - '--xperf_path', 03:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:41 INFO - 'tests': ['tp5n']}, 03:43:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:41 INFO - 'talos_options': ['--xperf_path', 03:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:41 INFO - 'tests': ['tp5n']}}, 03:43:41 INFO - 'talos.zip': {'path': '', 03:43:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:43:41 INFO - Running post-action listener: _resource_record_post_action 03:43:41 INFO - ##### 03:43:41 INFO - ##### Running create-virtualenv step. 03:43:41 INFO - ##### 03:43:41 INFO - Running pre-action listener: _resource_record_pre_action 03:43:41 INFO - Running main action method: create_virtualenv 03:43:41 INFO - Creating virtualenv /builds/slave/test/build/venv 03:43:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:43:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:43:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:43:41 INFO - Using real prefix '/usr' 03:43:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:43:42 INFO - Installing distribute.............................................................................................................................................................................................done. 03:43:44 INFO - Installing pip.................done. 03:43:44 INFO - Return code: 0 03:43:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd9f6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5410>, '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 0x1db6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:43:44 INFO - Using env: {'DISPLAY': ':0', 03:43:44 INFO - 'HOME': '/home/cltbld', 03:43:44 INFO - 'LANG': 'en_US.UTF-8', 03:43:44 INFO - 'LANGUAGE': 'en_US:en', 03:43:44 INFO - 'LOGNAME': 'cltbld', 03:43:44 INFO - 'MAIL': '/var/mail/cltbld', 03:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:44 INFO - 'MOZ_NO_REMOTE': '1', 03:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:44 INFO - 'NO_EM_RESTART': '1', 03:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:44 INFO - 'PWD': '/builds/slave/test', 03:43:44 INFO - 'SHELL': '/bin/bash', 03:43:44 INFO - 'SHLVL': '1', 03:43:44 INFO - 'TERM': 'linux', 03:43:44 INFO - 'TMOUT': '86400', 03:43:44 INFO - 'USER': 'cltbld', 03:43:44 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 03:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:44 INFO - '_': '/tools/buildbot/bin/python'} 03:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:43:44 INFO - Cleaning up... 03:43:44 INFO - Return code: 0 03:43:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fafd9f6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5410>, '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 0x1db6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:43:44 INFO - Using env: {'DISPLAY': ':0', 03:43:44 INFO - 'HOME': '/home/cltbld', 03:43:44 INFO - 'LANG': 'en_US.UTF-8', 03:43:44 INFO - 'LANGUAGE': 'en_US:en', 03:43:44 INFO - 'LOGNAME': 'cltbld', 03:43:44 INFO - 'MAIL': '/var/mail/cltbld', 03:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:44 INFO - 'MOZ_NO_REMOTE': '1', 03:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:44 INFO - 'NO_EM_RESTART': '1', 03:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:44 INFO - 'PWD': '/builds/slave/test', 03:43:44 INFO - 'SHELL': '/bin/bash', 03:43:44 INFO - 'SHLVL': '1', 03:43:44 INFO - 'TERM': 'linux', 03:43:44 INFO - 'TMOUT': '86400', 03:43:44 INFO - 'USER': 'cltbld', 03:43:44 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 03:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:44 INFO - '_': '/tools/buildbot/bin/python'} 03:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:44 INFO - Downloading/unpacking psutil>=0.7.1 03:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:43:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:46 INFO - Installing collected packages: psutil 03:43:46 INFO - Running setup.py install for psutil 03:43:46 INFO - building 'psutil._psutil_linux' extension 03:43:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:43:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:43:47 INFO - building 'psutil._psutil_posix' extension 03:43:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:43:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:47 INFO - Successfully installed psutil 03:43:47 INFO - Cleaning up... 03:43:47 INFO - Return code: 0 03:43:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fafd9f6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5410>, '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 0x1db6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:43:47 INFO - Using env: {'DISPLAY': ':0', 03:43:47 INFO - 'HOME': '/home/cltbld', 03:43:47 INFO - 'LANG': 'en_US.UTF-8', 03:43:47 INFO - 'LANGUAGE': 'en_US:en', 03:43:47 INFO - 'LOGNAME': 'cltbld', 03:43:47 INFO - 'MAIL': '/var/mail/cltbld', 03:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:47 INFO - 'MOZ_NO_REMOTE': '1', 03:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:47 INFO - 'NO_EM_RESTART': '1', 03:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:47 INFO - 'PWD': '/builds/slave/test', 03:43:47 INFO - 'SHELL': '/bin/bash', 03:43:47 INFO - 'SHLVL': '1', 03:43:47 INFO - 'TERM': 'linux', 03:43:47 INFO - 'TMOUT': '86400', 03:43:47 INFO - 'USER': 'cltbld', 03:43:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 03:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:47 INFO - '_': '/tools/buildbot/bin/python'} 03:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:43:49 INFO - Installing collected packages: mozsystemmonitor 03:43:49 INFO - Running setup.py install for mozsystemmonitor 03:43:49 INFO - Successfully installed mozsystemmonitor 03:43:49 INFO - Cleaning up... 03:43:49 INFO - Return code: 0 03:43:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:43: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')]} 03:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43: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')]} 03:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd9f6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5410>, '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 0x1db6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:43:49 INFO - Using env: {'DISPLAY': ':0', 03:43:49 INFO - 'HOME': '/home/cltbld', 03:43:49 INFO - 'LANG': 'en_US.UTF-8', 03:43:49 INFO - 'LANGUAGE': 'en_US:en', 03:43:49 INFO - 'LOGNAME': 'cltbld', 03:43:49 INFO - 'MAIL': '/var/mail/cltbld', 03:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:49 INFO - 'MOZ_NO_REMOTE': '1', 03:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:49 INFO - 'NO_EM_RESTART': '1', 03:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:49 INFO - 'PWD': '/builds/slave/test', 03:43:49 INFO - 'SHELL': '/bin/bash', 03:43:49 INFO - 'SHLVL': '1', 03:43:49 INFO - 'TERM': 'linux', 03:43:49 INFO - 'TMOUT': '86400', 03:43:49 INFO - 'USER': 'cltbld', 03:43:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 03:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:49 INFO - '_': '/tools/buildbot/bin/python'} 03:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:43:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:43:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - Downloading docopt-0.6.1.tar.gz 03:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:43:52 INFO - Installing collected packages: blobuploader, requests, docopt 03:43:52 INFO - Running setup.py install for blobuploader 03:43:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:43:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:43:52 INFO - Running setup.py install for requests 03:43:53 INFO - Running setup.py install for docopt 03:43:53 INFO - Successfully installed blobuploader requests docopt 03:43:53 INFO - Cleaning up... 03:43:53 INFO - Return code: 0 03:43:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd9f6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5410>, '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 0x1db6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:43:53 INFO - Using env: {'DISPLAY': ':0', 03:43:53 INFO - 'HOME': '/home/cltbld', 03:43:53 INFO - 'LANG': 'en_US.UTF-8', 03:43:53 INFO - 'LANGUAGE': 'en_US:en', 03:43:53 INFO - 'LOGNAME': 'cltbld', 03:43:53 INFO - 'MAIL': '/var/mail/cltbld', 03:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:53 INFO - 'MOZ_NO_REMOTE': '1', 03:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:53 INFO - 'NO_EM_RESTART': '1', 03:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:53 INFO - 'PWD': '/builds/slave/test', 03:43:53 INFO - 'SHELL': '/bin/bash', 03:43:53 INFO - 'SHLVL': '1', 03:43:53 INFO - 'TERM': 'linux', 03:43:53 INFO - 'TMOUT': '86400', 03:43:53 INFO - 'USER': 'cltbld', 03:43:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 03:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:53 INFO - '_': '/tools/buildbot/bin/python'} 03:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:53 INFO - Running setup.py (path:/tmp/pip-AvzyXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:53 INFO - Running setup.py (path:/tmp/pip-eK8o_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:53 INFO - Running setup.py (path:/tmp/pip-ToLyiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:53 INFO - Running setup.py (path:/tmp/pip-Gh5UJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:53 INFO - Running setup.py (path:/tmp/pip-2JHY3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:53 INFO - Running setup.py (path:/tmp/pip-ymj68d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:54 INFO - Running setup.py (path:/tmp/pip-DEWHVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:54 INFO - Running setup.py (path:/tmp/pip-ikW7kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:54 INFO - Running setup.py (path:/tmp/pip-VSy__A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:54 INFO - Running setup.py (path:/tmp/pip-Wt1yCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:54 INFO - Running setup.py (path:/tmp/pip-7Lpfjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:54 INFO - Running setup.py (path:/tmp/pip-rxvcDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:54 INFO - Running setup.py (path:/tmp/pip-wyXRtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:54 INFO - Running setup.py (path:/tmp/pip-jngh28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:54 INFO - Running setup.py (path:/tmp/pip-SbZ6dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:54 INFO - Running setup.py (path:/tmp/pip-BsYoVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:54 INFO - Running setup.py (path:/tmp/pip-EizsFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:43:54 INFO - Running setup.py install for manifestparser 03:43:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:43:54 INFO - Running setup.py install for mozcrash 03:43:55 INFO - Running setup.py install for mozdebug 03:43:55 INFO - Running setup.py install for mozdevice 03:43:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for mozfile 03:43:55 INFO - Running setup.py install for mozhttpd 03:43:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for mozinfo 03:43:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for mozInstall 03:43:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for mozleak 03:43:55 INFO - Running setup.py install for mozlog 03:43:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for moznetwork 03:43:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for mozprocess 03:43:56 INFO - Running setup.py install for mozprofile 03:43:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Running setup.py install for mozrunner 03:43:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Running setup.py install for mozscreenshot 03:43:56 INFO - Running setup.py install for moztest 03:43:56 INFO - Running setup.py install for mozversion 03:43:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:43:56 INFO - Cleaning up... 03:43:56 INFO - Return code: 0 03:43:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd9f6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5410>, '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 0x1db6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:43:56 INFO - Using env: {'DISPLAY': ':0', 03:43:56 INFO - 'HOME': '/home/cltbld', 03:43:56 INFO - 'LANG': 'en_US.UTF-8', 03:43:56 INFO - 'LANGUAGE': 'en_US:en', 03:43:56 INFO - 'LOGNAME': 'cltbld', 03:43:56 INFO - 'MAIL': '/var/mail/cltbld', 03:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:56 INFO - 'MOZ_NO_REMOTE': '1', 03:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:56 INFO - 'NO_EM_RESTART': '1', 03:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:56 INFO - 'PWD': '/builds/slave/test', 03:43:56 INFO - 'SHELL': '/bin/bash', 03:43:56 INFO - 'SHLVL': '1', 03:43:56 INFO - 'TERM': 'linux', 03:43:56 INFO - 'TMOUT': '86400', 03:43:56 INFO - 'USER': 'cltbld', 03:43:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 03:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:56 INFO - '_': '/tools/buildbot/bin/python'} 03:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:56 INFO - Running setup.py (path:/tmp/pip-w5fRC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:56 INFO - Running setup.py (path:/tmp/pip-GdVc7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:56 INFO - Running setup.py (path:/tmp/pip-mr4lx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:57 INFO - Running setup.py (path:/tmp/pip-gE_MTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:57 INFO - Running setup.py (path:/tmp/pip-RxTNn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:57 INFO - Running setup.py (path:/tmp/pip-Y9a9OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:57 INFO - Running setup.py (path:/tmp/pip-ZxAc7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:57 INFO - Running setup.py (path:/tmp/pip-pLUISM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:57 INFO - Running setup.py (path:/tmp/pip-XNfeIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:57 INFO - Running setup.py (path:/tmp/pip-iZ5zS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:57 INFO - Running setup.py (path:/tmp/pip-ztRexO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:57 INFO - Running setup.py (path:/tmp/pip-E9lDDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:57 INFO - Running setup.py (path:/tmp/pip-GUprHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:57 INFO - Running setup.py (path:/tmp/pip-EFN8CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:57 INFO - Running setup.py (path:/tmp/pip-kOGXyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:57 INFO - Running setup.py (path:/tmp/pip-M6AO5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:58 INFO - Running setup.py (path:/tmp/pip-2zP2hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:43:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:59 INFO - Downloading blessings-1.6.tar.gz 03:43:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:00 INFO - Installing collected packages: blessings 03:44:00 INFO - Running setup.py install for blessings 03:44:00 INFO - Successfully installed blessings 03:44:00 INFO - Cleaning up... 03:44:00 INFO - Return code: 0 03:44:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:00 INFO - Reading from file tmpfile_stdout 03:44:00 INFO - Current package versions: 03:44:00 INFO - argparse == 1.2.1 03:44:00 INFO - blessings == 1.6 03:44:00 INFO - blobuploader == 1.2.4 03:44:00 INFO - docopt == 0.6.1 03:44:00 INFO - manifestparser == 1.1 03:44:00 INFO - mozInstall == 1.12 03:44:00 INFO - mozcrash == 0.17 03:44:00 INFO - mozdebug == 0.1 03:44:00 INFO - mozdevice == 0.48 03:44:00 INFO - mozfile == 1.2 03:44:00 INFO - mozhttpd == 0.7 03:44:00 INFO - mozinfo == 0.9 03:44:00 INFO - mozleak == 0.1 03:44:00 INFO - mozlog == 3.1 03:44:00 INFO - moznetwork == 0.27 03:44:00 INFO - mozprocess == 0.22 03:44:00 INFO - mozprofile == 0.28 03:44:00 INFO - mozrunner == 6.11 03:44:00 INFO - mozscreenshot == 0.1 03:44:00 INFO - mozsystemmonitor == 0.0 03:44:00 INFO - moztest == 0.7 03:44:00 INFO - mozversion == 1.4 03:44:00 INFO - psutil == 3.1.1 03:44:00 INFO - requests == 1.2.3 03:44:00 INFO - wsgiref == 0.1.2 03:44:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd9f6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5410>, '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 0x1db6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:44:00 INFO - Using env: {'DISPLAY': ':0', 03:44:00 INFO - 'HOME': '/home/cltbld', 03:44:00 INFO - 'LANG': 'en_US.UTF-8', 03:44:00 INFO - 'LANGUAGE': 'en_US:en', 03:44:00 INFO - 'LOGNAME': 'cltbld', 03:44:00 INFO - 'MAIL': '/var/mail/cltbld', 03:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:00 INFO - 'MOZ_NO_REMOTE': '1', 03:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:00 INFO - 'NO_EM_RESTART': '1', 03:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:00 INFO - 'PWD': '/builds/slave/test', 03:44:00 INFO - 'SHELL': '/bin/bash', 03:44:00 INFO - 'SHLVL': '1', 03:44:00 INFO - 'TERM': 'linux', 03:44:00 INFO - 'TMOUT': '86400', 03:44:00 INFO - 'USER': 'cltbld', 03:44:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 03:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:00 INFO - '_': '/tools/buildbot/bin/python'} 03:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:44:00 INFO - Cleaning up... 03:44:00 INFO - Return code: 0 03:44:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafd9f6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5410>, '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 0x1db6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:44:00 INFO - Using env: {'DISPLAY': ':0', 03:44:00 INFO - 'HOME': '/home/cltbld', 03:44:00 INFO - 'LANG': 'en_US.UTF-8', 03:44:00 INFO - 'LANGUAGE': 'en_US:en', 03:44:00 INFO - 'LOGNAME': 'cltbld', 03:44:00 INFO - 'MAIL': '/var/mail/cltbld', 03:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:00 INFO - 'MOZ_NO_REMOTE': '1', 03:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:00 INFO - 'NO_EM_RESTART': '1', 03:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:00 INFO - 'PWD': '/builds/slave/test', 03:44:00 INFO - 'SHELL': '/bin/bash', 03:44:00 INFO - 'SHLVL': '1', 03:44:00 INFO - 'TERM': 'linux', 03:44:00 INFO - 'TMOUT': '86400', 03:44:00 INFO - 'USER': 'cltbld', 03:44:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 03:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:00 INFO - '_': '/tools/buildbot/bin/python'} 03:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:00 INFO - Downloading/unpacking jsonschema 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:44:02 INFO - Downloading/unpacking functools32 (from jsonschema) 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:44:03 INFO - warning: no files found matching '*.txt' 03:44:03 INFO - no previously-included directories found matching 'build' 03:44:03 INFO - no previously-included directories found matching 'dist' 03:44:03 INFO - no previously-included directories found matching '.git*' 03:44:03 INFO - Installing collected packages: jsonschema, functools32 03:44:03 INFO - Running setup.py install for functools32 03:44:03 INFO - warning: no files found matching '*.txt' 03:44:03 INFO - no previously-included directories found matching 'build' 03:44:03 INFO - no previously-included directories found matching 'dist' 03:44:03 INFO - no previously-included directories found matching '.git*' 03:44:03 INFO - Successfully installed jsonschema functools32 03:44:03 INFO - Cleaning up... 03:44:03 INFO - Return code: 0 03:44:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:03 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 0x7fafd9f6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d265a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db5410>, '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 0x1db6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db67a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:44:03 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 03:44:03 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 03:44:03 INFO - Using env: {'DISPLAY': ':0', 03:44:03 INFO - 'HOME': '/home/cltbld', 03:44:03 INFO - 'LANG': 'en_US.UTF-8', 03:44:03 INFO - 'LANGUAGE': 'en_US:en', 03:44:03 INFO - 'LOGNAME': 'cltbld', 03:44:03 INFO - 'MAIL': '/var/mail/cltbld', 03:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:03 INFO - 'MOZ_NO_REMOTE': '1', 03:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:03 INFO - 'NO_EM_RESTART': '1', 03:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:03 INFO - 'PWD': '/builds/slave/test', 03:44:03 INFO - 'SHELL': '/bin/bash', 03:44:03 INFO - 'SHLVL': '1', 03:44:03 INFO - 'TERM': 'linux', 03:44:03 INFO - 'TMOUT': '86400', 03:44:03 INFO - 'USER': 'cltbld', 03:44:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 03:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:03 INFO - '_': '/tools/buildbot/bin/python'} 03:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:03 INFO - Downloading/unpacking flake8 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:44:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:44:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:44:06 INFO - no previously-included directories found matching 'docs/_build' 03:44:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:44:06 INFO - Running setup.py install for pep8 03:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:44:06 INFO - no previously-included directories found matching 'docs/_build' 03:44:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:44:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:44:06 INFO - Cleaning up... 03:44:06 INFO - Return code: 0 03:44:06 INFO - Running post-action listener: _resource_record_post_action 03:44:06 INFO - Running post-action listener: _start_resource_monitoring 03:44:06 INFO - Starting resource monitoring. 03:44:06 INFO - ##### 03:44:06 INFO - ##### Running install step. 03:44:06 INFO - ##### 03:44:06 INFO - Running pre-action listener: _resource_record_pre_action 03:44:06 INFO - Running main action method: install 03:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:06 INFO - Reading from file tmpfile_stdout 03:44:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:06 INFO - Reading from file tmpfile_stdout 03:44:06 INFO - Output received: 03:44:06 INFO - Usage: mozinstall [options] installer 03:44:06 INFO - Options: 03:44:06 INFO - -h, --help show this help message and exit 03:44:06 INFO - -d DEST, --destination=DEST 03:44:06 INFO - Directory to install application into. [default: 03:44:06 INFO - "/builds/slave/test"] 03:44:06 INFO - --app=APP Application being installed. [default: firefox] 03:44:06 INFO - mkdir: /builds/slave/test/build/application 03:44:06 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'] 03:44:06 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 03:44:19 INFO - Reading from file tmpfile_stdout 03:44:19 INFO - Output received: 03:44:19 INFO - /builds/slave/test/build/application/firefox/firefox 03:44:19 INFO - Running post-action listener: _resource_record_post_action 03:44:19 INFO - ##### 03:44:19 INFO - ##### Running run-tests step. 03:44:19 INFO - ##### 03:44:19 INFO - Running pre-action listener: _resource_record_pre_action 03:44:19 INFO - Running main action method: run_tests 03:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:19 INFO - Python 2.7.3 03:44:19 INFO - Return code: 0 03:44:19 INFO - grabbing minidump binary from tooltool 03:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:19 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 0x1db5410>, '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 0x1db6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:44:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:44:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:19 INFO - Return code: 0 03:44:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:44:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:44:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:44:20 INFO - Return code: 0 03:44:20 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/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 03:44:20 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/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 03:44:20 INFO - Using env: {'DISPLAY': ':0', 03:44:20 INFO - 'HOME': '/home/cltbld', 03:44:20 INFO - 'LANG': 'en_US.UTF-8', 03:44:20 INFO - 'LANGUAGE': 'en_US:en', 03:44:20 INFO - 'LOGNAME': 'cltbld', 03:44:20 INFO - 'MAIL': '/var/mail/cltbld', 03:44:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:20 INFO - 'MOZ_NO_REMOTE': '1', 03:44:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:20 INFO - 'NO_EM_RESTART': '1', 03:44:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:20 INFO - 'PWD': '/builds/slave/test', 03:44:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:20 INFO - 'SHELL': '/bin/bash', 03:44:20 INFO - 'SHLVL': '1', 03:44:20 INFO - 'TERM': 'linux', 03:44:20 INFO - 'TMOUT': '86400', 03:44:20 INFO - 'USER': 'cltbld', 03:44:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042', 03:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:20 INFO - '_': '/tools/buildbot/bin/python'} 03:44:20 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/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 03:44:21 INFO - mozversion application_buildid: 20160613005526 03:44:21 INFO - mozversion application_changeset: 2539cf53e85d348397cdee353061a34e8b0f11fb 03:44:21 INFO - mozversion application_display_name: Firefox 03:44:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:21 INFO - mozversion application_name: Firefox 03:44:21 INFO - mozversion application_remotingname: firefox 03:44:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:44:21 INFO - mozversion application_vendor: Mozilla 03:44:21 INFO - mozversion application_version: 48.0 03:44:21 INFO - mozversion platform_buildid: 20160613005526 03:44:21 INFO - mozversion platform_changeset: 2539cf53e85d348397cdee353061a34e8b0f11fb 03:44:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:44:21 INFO - mozversion platform_version: 48.0 03:44:21 INFO - using testdate: 1465814661 03:44:21 INFO - actual date: 1465814661 03:44:21 INFO - starting webserver on 'localhost:38897' 03:44:21 INFO - SUITE-START | Running 2 tests 03:44:21 INFO - TEST-START | dromaeo_css 03:44:21 INFO - operating with platform_type : linux_ 03:44:21 INFO - Initialising browser for dromaeo_css test... 03:44:21 INFO - TEST-INFO | started process 9742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprQ8Wg0/profile http://localhost:38897/getInfo.html) 03:44:24 INFO - PROCESS | 9742 | __metrics Screen width/height:1600/1200 03:44:24 INFO - PROCESS | 9742 | colorDepth:24 03:44:24 INFO - PROCESS | 9742 | Browser inner width/height: 1024/697 03:44:24 INFO - PROCESS | 9742 | __metrics 03:44:25 ERROR - PROCESS | 9742 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:44:26 INFO - TEST-INFO | 9742: exit 0 03:44:26 INFO - Browser initialized. 03:44:26 INFO - Running cycle 1/1 for dromaeo_css test... 03:44:26 INFO - TEST-INFO | started process 9834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprQ8Wg0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:38 INFO - PROCESS | 9834 | RSS: Main: 141565952 03:44:38 INFO - PROCESS | 9834 | 03:45:29 INFO - PROCESS | 9834 | 1465814729619 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:47:36 INFO - PROCESS | 9834 | Cycle 1(1): loaded http://localhost:38897/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38897/tests/dromaeo/cssquery-ext.html) 03:47:37 INFO - PROCESS | 9834 | RSS: Main: 252395520 03:47:37 INFO - PROCESS | 9834 | 03:50:39 INFO - PROCESS | 9834 | Cycle 1(1): loaded http://localhost:38897/tests/dromaeo/cssquery-ext.html (next: http://localhost:38897/tests/dromaeo/cssquery-jquery.html) 03:50:40 INFO - PROCESS | 9834 | RSS: Main: 227356672 03:50:40 INFO - PROCESS | 9834 | 03:53:41 INFO - PROCESS | 9834 | Cycle 1(1): loaded http://localhost:38897/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38897/tests/dromaeo/cssquery-mootools.html) 03:53:42 INFO - PROCESS | 9834 | RSS: Main: 223379456 03:53:42 INFO - PROCESS | 9834 | 03:56:44 INFO - PROCESS | 9834 | Cycle 1(1): loaded http://localhost:38897/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38897/tests/dromaeo/cssquery-prototype.html) 03:56:44 INFO - PROCESS | 9834 | RSS: Main: 223522816 03:56:44 INFO - PROCESS | 9834 | 03:59:47 INFO - PROCESS | 9834 | Cycle 1(1): loaded http://localhost:38897/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38897/tests/dromaeo/cssquery-yui.html) 03:59:47 INFO - PROCESS | 9834 | RSS: Main: 188612608 03:59:47 INFO - PROCESS | 9834 | 04:02:50 INFO - PROCESS | 9834 | Cycle 1(1): loaded http://localhost:38897/tests/dromaeo/cssquery-yui.html (next: http://localhost:38897/tests/dromaeo/cssquery-dojo.html) 04:02:50 INFO - PROCESS | 9834 | RSS: Main: 255299584 04:02:50 INFO - PROCESS | 9834 | 04:02:50 INFO - PROCESS | 9834 | __start_tp_report 04:02:50 INFO - PROCESS | 9834 | _x_x_mozilla_page_load 04:02:50 INFO - PROCESS | 9834 | _x_x_mozilla_page_load_details 04:02:50 INFO - PROCESS | 9834 | |i|pagename|runs| 04:02:50 INFO - PROCESS | 9834 | |0;dojo.html;3240.1251662051245;3300.12546675131;3313.2545177335087;3345.1135449105977;3357.0264623259254;5444.537214336781;5466.070767969445;5466.28938238029;5472.890542189164;5493.752781124854;5442.12925931851;5449.04641687705;5470.316210473691;5475.890482190353;5511;4980.900381992367;5015.473375295596;5033.320501732256;5054.090263752523;5105.489451054883;5036.445990940993;5069.062223488648;5074.441811400743;5119.923201151967;5140.948590514085;5063.46833582474;5102.489751024887;5104.515071068261;5105.923411148836;5134.974325128369;5011.423686276088;5040.747962601855;5092.84721458355;5095.668781529207;5102.413222479426;4926.950730492685;4950.603951683893;5009.373828271466;5018.121828679967;5044.066847633163;5373.032854086263;5392.514673679388;5399.865003374908;5402.837914862561;5420.972895135538;5732.684702341369;5838.182654428383;5855.707214639294;5855.882882342372;5892.616979896293;5972.880542389172;6044.395560443964;6049.032154855202;6074.5747797654185;6080.817575472743;5494.725263736797;5495.780168793243;5500.202470641734;5511.311086114236;5543.473370029841;5948.315943666534;5965.582409231399;5967.224260846149;5996.790112346047;5999.700014999233;5753.194552762617;5758.0787074068785;5763.308402991668;5765.279340082489;5792.565557583198;5831.358550559435;5844.211031510692;5845.123231515222;5845.824625261249;5845.853853653693;5705.372409035002;5788.0449725795615;5802.738876750556;5825.854353641193;5910.763569457259;5904.5571582131515;5907.350191478934;5908.379620139909;5914.319853216849;5915.3788852170765;4406.735595864258;4495.033567782943;4503.819847206075;4524.547545245515;4527.932081018787;3980.3631418972827;3997.2205419942834;4032.213718324957;4059.878203653895;4069.104796944667;5570.777168913198;5584.972075139598;5593.105103183471;5600.6919619420505;5643.830685079454;5797.333306669702;5926.2295901532525;5937.643741375531;5939.940600594025;5945.108233764883;5553.111502159716;5575.080111781511;5583.804566840141;5594.860128496739;5614.775408983595;5087.796488140507;5097.158968770112;5100.744962751922;5103.464136265713;5124.92312615311;5916.230889984275;6076.726547305293;6108.969455152785;6116.816495505142;6120;5906.26171728534;5911.615744976562;5927.525797936069;5934.287885453773;5940.049592065248;6090.634561926121;6109.450149486567;6112.786052488142;6112.816615501542;6115.7247923844425;5683.5453163747625;5807.535397168132;5809.854753631024;5824.126381042877;5828.883422331445;5857.824265272048;5906.940930590639;5916.674582897982;5921.348651648402;5951.851203719942;5732.828015159552;5763.596548241583;5766.423357664368;5770.596058276048;5780.219670344618;5582;5734.59857809966;5740.454656807597;5753.1370294456165;5814.5348372130975;5630.831075067755;5632.887342253214;5637.267155269788;5655.095184770417;5661.773529058792;5705.7147142643535;5739.540836733135;5761.5390768739235;5762.481376676119;5764.308283006066;5573.3869274380595;5617.606767526234;5641.576881733969;5662.546996240373;5672.688002159921 04:02:50 INFO - PROCESS | 9834 | |1;ext.html;660.0956689335611;668.5086461450836;673.8517526144248;683.0744341417376;748.3863232149638;33306.50040249395;33927.15182120448;40506.7974660127;41102.58897411025;41146.38280425796;43293.35059974103;43396.783016084875;43899;43920.78039609797;43951.340729889074;7782;8742.082081381459;8909.643614255454;8910.688125915594;8918.152775486318;10629.096526795232;10914.563417463292;10920.563177472892;10924.781504369908;10925.617603383884;10531.473426328692;10549.68350949469;10636.46817659114;10637.255392122555;10646.041856232938;10484.63303784364;10485.213608979318;10551.525181366856;10563.947180264126;10565.366078035266;10398;10513.053825155695;10514.737131571772;10520.263581549294;10532.210084243636;45132.77433612811;45548.3167752484;45551.77224113891;45655.08689826185;45694.77152614249;3825.5218097737784;3849.8845034649007;3998.7000974926705;4143.6685065194715;4524.547545245482;33301.33397332064;33513;33775.6622433775;33785.32429351424;33822.83088584541;4249.3625956106525;4330.458692663417;4357.9128417431475;4401.801918913657;4414.977925110386;250681;251951;252774;252819;253424;62547;63387.36612633907;63398.6830065856;63473.36526634767;63755;66620.33379666142;71124.64437677778;71627;71802.28197717956;72024.63987680028;18853.24587016504;18906.62186756257;18933.715994260096;18938.337158199396;18947.526311842314;13195.868041319463;14097.083689560352;15304.38782448712;15400.22998850053;15570.9221453892;19863.205471780966;20090.698639520127;20160.49598760043;20162;20169;7143.24995875436;7413.777586672409;7470.103587569418;7522.6614802334025;7570;1118.2731224704007;1124.7244425115734;1150.6605551362368;1180.3213152437384;1193.1707463312914;33924.58323362824;34023.489647655304;34043;34354.31291374158;34492;1221.4930803716359;1246.6447062587301;1274.4710944957924;1291.651254161371;1341.926194059336;17301.221445035004;17975.82031133576;18022.639547209244;18187.363442279457;18194.4340446774;499225;499596;502448;504213;504868;62241.377586224466;62585.68707156435;62903.685481573215;62958.370416296166;62977.68511157415;1369.9520516782063;1477.121112937779;1490.2027415332745;1515.5907904865624;1617.9757303640454;30081.398372032876;31514.212144696565;31855.522167167048;31998;32592.837035814668;49389.25916111189;50149;50190.247146293565;50256.74871625618;50322.7483862593;324100;324149;325171;326394;327510;26874;27405.31486712848;30264.394712106074;30661.080167595006;30885.536716949715;43656.78171609122;44214.778926105166;45230.773846130556;45495.31757023714;45656.31515527203;35292.647073529966;37484;38632;39236.21527569376;40374.798126009184;38792.22415551617;40235.1952960945;40779.7961010193;40827.38758918678;42093.78953105215;42473.787631062885;45048.77475612732;45652.54347456483;46514;46629.53370466252;36000.81999589985;36619.45070823993;37210.813945930095;37305;38400.80799595984;29064.56403153912;29467;29538.261543461584;29753.10740677783;29816.552751708306 04:02:50 INFO - PROCESS | 9834 | |2;jquery.html;423.32057048437247;425.4235510882756;429.8474041715193;439.72517176764524;440.7994362565033;18726.812731872677;19222;19425.12586933588;19480.70778938317;19830.60338793223;17370.56573585661;17568.472945811613;18899.149538270776;19687;19687.606247875035;4862.927056094161;5237.7381130943395;5393.78424863005;5637.295338082739;5639.210510528529;5839.240898683165;5842.707864606774;5869.06095024794;5872.500837428824;5881.029630111048;5645.463680950324;5836.883262334751;5859.619124756899;5879.235699359077;5881.558883083786;5876.706164691748;5879.735411906453;5894.351621321694;5896.734646940855;5908.291005079396;5374.059539580558;5384.084705600018;5444.945550544483;5712.828615141552;5721.4850663440075;14040.438382464688;14199.929000354932;14329.140251584835;21169.259075932423;23431.53136937252;2241.540484200735;2278.669592909019;2332.6151185054446;2375.5842727522613;2429.6234083717054;10362.119219866321;10415.739606509822;10430.947845260802;10501.632442864464;12572.371381430983;2025.8379329653592;2226.476777957179;2295.827812914038;2339.660749191358;2420.9273721788372;91991.54004229936;93843;97053;97384;98209.5089524555;18715.532111697317;18797.15412806427;19017.00321466226;19077.523061923563;19320.227190912487;34704.132396689776;34881.9535413938;34977.65022349795;35119;35474.29051418957;8627.95686021566;8680.348973826862;8694;8895.555222238992;9182.77043073915;8656.394052416397;8996.190342869042;9024.593893274818;9041.63833446668;9116.49859257734;5075.365579302587;5197.506236907488;5208.036513244986;5237.292965449692;5242.633015688942;2029.2288930206428;2081.6669332906963;2107.262458139639;2110.366889933014;2168.6638571021517;479.2284422080448;1085.6634443322437;1105.9447027648746;1108.6286094158386;1213.919611545725;11750;12203.633890983285;12232.204906681038;12240.81638775419;12335.444904979298;482.96860704054126;491.46675856695884;494.6619394537839;500.412015881338;503.5669324381029;6432.678366081677;6527.379898909596;6576.769813056616;6580.473562115019;6655.600663960178;559006;571478;622748;629491;633677;101376;105513;106631.4668426653;106920;107248.46375768071;506.6453482562221;511.3276042004752;514.5471984653481;515.9019786240602;516.4757770862652;11195.60815371458;11284.097272218367;11532.82700759506;11545.769084618092;11710.765784684429;37943.430848536744;38375.80812095922;38852;39666.60333396629;40463.393049104874;60009.39990600213;63918.68040659767;64094.35905641071;64364.356356435834;64457.67771161114;8846.248068914214;12061.81907271374;12507.187032842836;13188.449984755627;13296.86703132995;13525.864741352461;13541.187528748307;13934.71691516204;13994.860051399355;14156.50452234167;12441.564545241235;12726.68183295425;13142.145760525918;13327.533536326182;13622.86377136216;8355.623996920274;8574.571271436278;8679.956600216958;8696.304295656459;8930.240929521064;8523.573821309034;9078.500682462263;9174.724758257264;9196.08039196075;9726.513674316115;12853.357332133543;12878.678033048875;12890.09769316139;12916.870831291943;12922.612321630366;12259.816102758645;12417.565385211474;12509.374531273583;12512.562060327844;12706.618801435972 04:02:50 INFO - PROCESS | 9834 | |3;mootools.html;1373.924434156121;1551.239892452698;1554.9533513994581;1764.2501936676917;1866.7479890214818;8146.144654811241;8282.958585207072;8310.002799664033;8332.66669333226;8335.208155225258;8122.634481448335;8280.792980175484;8312.833743325129;8314.750557483285;8328.20882016209;2400.0999625140616;2408.95182096358;2423.5516429460517;2430.0887167312258;2430.501747141832;2435.902563897442;2460.520198561281;2472.171822439485;2481.131603938616;2495.563276426618;2358.79950204232;2390.9043638254448;2393.7725916038034;2394.5330660521204;2410.770976757205;2412.16780210827;2437.744036876129;2456.7297597264287;2457.3242358351417;2458.864762438065;2373.4896997145697;2450.656908032877;2456.152627343564;2470.2712699753615;2490.302715239736;7445.404367650629;7594.354479869163;8473.195046470575;8527.786805329853;8541.017782954916;5103.387593488805;5191.299174611417;5192.480751924815;5194.870128246824;5195.298634684307;3494.842732077037;3501.8249087545773;3574.070741607175;3583.1937813991644;3619.2580520993133;1125.352922069813;1130.8586426696663;1131.903788178006;1151.2862025544132;1153.0199330569033;11554.884451155549;11666.125040621988;11669.649910502698;12032.939835300855;12078.879211207863;4501.167284052395;4511.887202819956;4587.747673877969;4588.839390621312;4610.077984403066;10332.483375831178;10389.792204155874;10439.217058720626;10442.164626829835;10448.164146868232;5290.100682883919;5316.787328506894;5327;5336.306280183551;5339.973300133474;4887.486813884562;4889.193283108319;4893.6329775266995;4895.510448955147;4896.387951506062;3781.1870447853844;4003.579624139482;4021.2761702893176;4021.8994525137105;4050.210209009274;1212.0485418946084;1236.9567065152855;1239.7396546725108;1255.5417272695584;1258.2261908925946;912.3431129586687;930.1907340613709;1083.0739717541546;1088.7278180454887;1098.1269890437122;6082.574219804571;6102.611782604964;6138.7237574309265;6196.318404975449;6301.243850737849;474.89077512172395;476.3474040564449;483.4802587218754;483.84033269021137;494.1821285772053;4064.695147863922;4068.6948478864206;4145.523264824584;4289.613934745826;4294.613484786384;10306.639267625596;10428.217883658755;10654.62708805188;10674.57301707923;10738.624148154777;10292.279540432099;10323.741906452398;10403.063724264852;10423.374597524173;10424.166066714644;7900.881486777703;7911.920880791118;8079.949606551111;8086.070101938352;8151.470154439942;5664.122061080539;5696.430356964271;5744.885102297847;5810.622309549865;5876.236089308362;9058.637654493747;9082.091790820865;9304.302177336862;9329.673461428818;9588.37675551087;9160.175584197454;9338.813223735624;9367.718968430958;9421.057894210524;9450.574724137568;7459.104907411145;7500.962495187489;7520.059992500937;7584.127825300161;7587.962060189664;8114.188581141839;8149.225823546753;8154.836903261783;8187.385946053951;8217.712380066669;7222.09723784527;7383.040204773345;7574.734884279023;7653.808654783452;7730.845383092194;7429.182789893215;7510.47426680149;7518.210587888193;7590;7608.733694320672;6976.930230697831;6977.581345119309;6980.860382792214;7008.474364422791;7019.508634395747;4410.470743510799;4998.725070121178;5137.8201762938115;5239.685618862881;5268.6575372600655;4782.593479554277;4926.827561035347;4964.379452568429;5012.523810238022;5063.87340316495 04:02:50 INFO - PROCESS | 9834 | |4;prototype.html;353.9964600353996;363.10675737685295;364.2023967511152;366.58026559589257;367.24531088612906;6240.875182496358;6333.651649159295;6401.295857455676;6428.1000659907595;6476.287608363088;6294.464970477515;6370.394812492817;6420.903686444695;6425.614463132215;6468.029795530672;4943.579795717359;4959.355283813099;4966.056449274644;4966.478519755427;4971.577415919651;4711.929321060187;4777.952220477786;4920.8277710280145;4960.627952903528;4966.627502937276;4897.4123105227245;4905.975470122645;4907;4913.606911447094;4916.877078073041;4884.682495637772;4888.364512613373;4889.3399391082285;4903.215485522299;4921.360223171001;4298.527162012176;4310.655147588185;4328.372386004044;4336.718113322656;4339.587739164775;6161.229846269216;6181.3818618138275;6182.814515564541;6188.412100850412;6208.813735587894;5582.665040097567;5707.14392841073;5714.285714285715;5714.685692286923;5723;6717.42901853343;6744.662766861687;6745.527813053088;6745.527813053088;6747.05541224229;4791.209450440673;4795.064962332347;4799.472058073609;4801.303810947393;4803.9039219215765;7048.259932707043;7051.506394552383;7054.999999999949;7056.611886346249;7068.11648543932;4906.852794416173;4909.656324057353;4916.729579873141;4919.458859525449;4919.540229885058;4570.154521413549;4739.289106634033;4977.32806071183;4985;4995.075910956485;5518.255035570227;5541.33503979525;5545.195946587723;5551.417101204396;5554.333479982428;6771.695273712695;6788.932110678928;6792.049113124167;6807.829804254933;6810.965945170243;1621.5459671292058;1717.5534361065963;1754.2456743600374;1760.6830770461183;1770.2034084661955;1163.7381589142544;1177.9941100294443;1189.2745425290566;1193.8567371915426;1195.3664557784389;6431.067495213168;6481.384268494486;6484.935150648527;6485.837854053686;6503.154589903283;6934.722611095601;6957.9304206958295;6961.129858767654;6988.371046605728;6989.93010069903;6482.286948435668;6484.935150648527;6489.572294095292;6496.382843629847;6497.707603157869;3732.42147467143;3763.2661630981697;3765.134019175605;3767.773933563995;3772.43413487979;6991.440684745208;7292.270772922665;7316;7345.338919497164;7351.375133113638;7219.711211551479;7234.96382518084;7237.203907570163;7253.419726421874;7260;7303.59830209333;7305.5981920994855;7311.232320606367;7314.26857314275;7321.670524826395;6936.653167341512;7070.151581810215;7081.114860642419;7084.36240738336;7095.574265544084;6938.653067346511;6974.093367862146;6975.651217439209;6977.33715297046;6983.441324694114;7240.963795181201;7269.963650181715;7279.381252593589;7307.634618269171;7308.04995350601;4772.475027746876;4825.9758701206265;4826.517348265286;4827.08285425768;4845.079434907357;6793.898091528532;6815.727370905108;7042.964785176041;7049.9647501762165;7054.894176587252;6829.248782634006;6841;6863.897041544481;6864.107666003388;6871.553349032297;6835.487338449736;6835.863282734417;6858.691358888762;6867;6871.03805467225;6729.596224226562;6742.157230346207;6754.290799465985;6758.459323254227;6759;6740.325967403221;6899.103116594811;6903.6203008835;6912.516123871281;6918.481113916577;6736.090627765385;6752.291009444134;6758.662066896537;6760.560563563353;6763.526553141233 04:02:50 INFO - PROCESS | 9834 | |5;yui.html;798.1539568057859;801.5711594297048;844.8437039147755;923.3075193604794;923.6351641101764;15257.923710381447;16551.834481655194;16753.413630522933;16774.07742574158;16775.58061048473;15176.924115379408;15215.695686086272;15257.237138143104;15286.2356882156;15324.233788310568;784.1139512351064;924.5977999570175;931.7437704631213;945.2201933404934;949.0319873728793;930.144267274106;933.1228645073643;938.6761567259284;938.9859152112724;939.8214339275515;965.9661911833088;973.1971123822839;976.85835553845;977.49170431376;977.8386566216566;826.3224156191925;965.2663975378692;969.0406497567428;979.6032606794224;979.7501637082498;713.1050531582882;713.6752777486231;713.8607971445571;714.2536049827942;714.2821464428268;15243.390264389522;15268.694626107526;15301.464448744351;15303.311350989232;15317.617059573487;14192.9355298352;14568.125912445286;14739.410423583044;14808.407663693439;15393.307301171362;12202.694932626666;12236.204646698025;12291.139620226588;12324.81512777309;12362;4014.1770936957855;4048.392741088831;4113.1568028554075;4114.362273847529;4138.0689344897455;57312.71343643297;57380.42619573793;57420.71289643525;57500.71249643725;57536;11678.88321116795;11874.465649045813;11943.581974630846;11943.88056119445;12013.339266340436;22036.779632203794;22067.11731530753;22078.11687532513;22102.336929892128;22143.889280553492;8664.956675216583;8741.956290218635;8810.955945220232;8870.246029087471;9161.221296189766;4891.951080489221;4910.140725373046;4912.754362281943;4913.361263035782;4938.135826230396;3375.0549846043145;3403.6256011838677;3409.880654177092;3413.197898493852;3416.8804091857164;567.5402923631789;587.1310460518457;608.4554323880103;651.1697585578331;670.2258890980925;691.5021184747075;706.4489698035541;711.7544447165719;755.7014979083341;783.3576467296762;9399.530023498797;9473.715788526355;9493.477858717699;9514.137793707741;9738.269629777795;637.0985056145502;637.4740838808002;658.5883822610868;701.1971292869636;741.525423728814;4554.157480866051;4564.954350456519;4590.495045544987;4706.7411292378565;4783.115123702126;63357;63492;64016;64531.35468645347;64538.35461645418;56560;57558.7122064387;57614;57749.422505774404;57768.422315776304;47001.529984699715;48675.02649947052;49855.750721246884;51511.22733159005;51696.44910652687;9145.45127292338;9160.816783664157;9203.86194207074;9287.210587100171;9289.303302252494;38025.61974380331;38517;39528;39608.40587391134;39670.80164599159;43515.34726979034;43931;44382.77808610936;48027.5197248023;49039;12889.8066529004;12928.612141635766;13017.544385946447;13216.405261763435;13292.335383230993;13994.790078148631;14093.436262549383;14403.92798036045;14850.480233192218;14958.32687529042;11565.595204167814;13477.528286509925;13806.033577649468;13858.792118118437;14205.431782728576;13297.26865022433;13482.752932826128;13559.796603050765;13997.930010349883;14339.996200265881;12885.162464439782;13109.410076546768;13111.2133272004;13362.331883405985;13426.462941482232;11000.22998390105;11238.325700458;11242;11403.201775875608;11559.942200288944;10996.340219586851;11214.15893807984;11236.438178090899;11514.251573647685;11527.135464840003 04:02:50 INFO - PROCESS | 9834 | __end_tp_report 04:02:50 INFO - PROCESS | 9834 | __start_cc_report 04:02:50 INFO - PROCESS | 9834 | _x_x_mozilla_cycle_collect,875 04:02:50 INFO - PROCESS | 9834 | __end_cc_report 04:02:50 INFO - PROCESS | 9834 | __startTimestamp1465815770473__endTimestamp 04:02:50 INFO - PROCESS | 9834 | 04:02:50 INFO - PROCESS | 9834 | ------- Summary: start ------- 04:02:50 INFO - PROCESS | 9834 | Number of tests: 6 04:02:50 INFO - PROCESS | 9834 | 04:02:50 INFO - PROCESS | 9834 | [#0] dojo.html Cycles:165 Average:5474.28 Median:5655.10 stddev:599.05 (10.6%) stddev-sans-first:574.67 04:02:50 INFO - PROCESS | 9834 | Values: 3240.1 3300.1 3313.3 3345.1 3357.0 5444.5 5466.1 5466.3 5472.9 5493.8 5442.1 5449.0 5470.3 5475.9 5511.0 4980.9 5015.5 5033.3 5054.1 5105.5 5036.4 5069.1 5074.4 5119.9 5140.9 5063.5 5102.5 5104.5 5105.9 5135.0 5011.4 5040.7 5092.8 5095.7 5102.4 4927.0 4950.6 5009.4 5018.1 5044.1 5373.0 5392.5 5399.9 5402.8 5421.0 5732.7 5838.2 5855.7 5855.9 5892.6 5972.9 6044.4 6049.0 6074.6 6080.8 5494.7 5495.8 5500.2 5511.3 5543.5 5948.3 5965.6 5967.2 5996.8 5999.7 5753.2 5758.1 5763.3 5765.3 5792.6 5831.4 5844.2 5845.1 5845.8 5845.9 5705.4 5788.0 5802.7 5825.9 5910.8 5904.6 5907.4 5908.4 5914.3 5915.4 4406.7 4495.0 4503.8 4524.5 4527.9 3980.4 3997.2 4032.2 4059.9 4069.1 5570.8 5585.0 5593.1 5600.7 5643.8 5797.3 5926.2 5937.6 5939.9 5945.1 5553.1 5575.1 5583.8 5594.9 5614.8 5087.8 5097.2 5100.7 5103.5 5124.9 5916.2 6076.7 6109.0 6116.8 6120.0 5906.3 5911.6 5927.5 5934.3 5940.0 6090.6 6109.5 6112.8 6112.8 6115.7 5683.5 5807.5 5809.9 5824.1 5828.9 5857.8 5906.9 5916.7 5921.3 5951.9 5732.8 5763.6 5766.4 5770.6 5780.2 5582.0 5734.6 5740.5 5753.1 5814.5 5630.8 5632.9 5637.3 5655.1 5661.8 5705.7 5739.5 5761.5 5762.5 5764.3 5573.4 5617.6 5641.6 5662.5 5672.7 04:02:50 INFO - PROCESS | 9834 | 04:02:50 INFO - PROCESS | 9834 | [#1] ext.html Cycles:180 Average:54477.79 Median:34423.16 stddev:99048.50 (287.7%) stddev-sans-first:99243.94 04:02:50 INFO - PROCESS | 9834 | Values: 660.1 668.5 673.9 683.1 748.4 33306.5 33927.2 40506.8 41102.6 41146.4 43293.4 43396.8 43899.0 43920.8 43951.3 7782.0 8742.1 8909.6 8910.7 8918.2 10629.1 10914.6 10920.6 10924.8 10925.6 10531.5 10549.7 10636.5 10637.3 10646.0 10484.6 10485.2 10551.5 10563.9 10565.4 10398.0 10513.1 10514.7 10520.3 10532.2 45132.8 45548.3 45551.8 45655.1 45694.8 3825.5 3849.9 3998.7 4143.7 4524.5 33301.3 33513.0 33775.7 33785.3 33822.8 4249.4 4330.5 4357.9 4401.8 4415.0 250681.0 251951.0 252774.0 252819.0 253424.0 62547.0 63387.4 63398.7 63473.4 63755.0 66620.3 71124.6 71627.0 71802.3 72024.6 18853.2 18906.6 18933.7 18938.3 18947.5 13195.9 14097.1 15304.4 15400.2 15570.9 19863.2 20090.7 20160.5 20162.0 20169.0 7143.2 7413.8 7470.1 7522.7 7570.0 1118.3 1124.7 1150.7 1180.3 1193.2 33924.6 34023.5 34043.0 34354.3 34492.0 1221.5 1246.6 1274.5 1291.7 1341.9 17301.2 17975.8 18022.6 18187.4 18194.4 499225.0 499596.0 502448.0 504213.0 504868.0 62241.4 62585.7 62903.7 62958.4 62977.7 1370.0 1477.1 1490.2 1515.6 1618.0 30081.4 31514.2 31855.5 31998.0 32592.8 49389.3 50149.0 50190.2 50256.7 50322.7 324100.0 324149.0 325171.0 326394.0 327510.0 26874.0 27405.3 30264.4 30661.1 30885.5 43656.8 44214.8 45230.8 45495.3 45656.3 35292.6 37484.0 38632.0 39236.2 40374.8 38792.2 40235.2 40779.8 40827.4 42093.8 42473.8 45048.8 45652.5 46514.0 46629.5 36000.8 36619.5 37210.8 37305.0 38400.8 29064.6 29467.0 29538.3 29753.1 29816.6 04:02:50 INFO - PROCESS | 9834 | 04:02:50 INFO - PROCESS | 9834 | [#2] jquery.html Cycles:180 Average:33332.65 Median:39259.30 stddev:99610.40 (253.7%) stddev-sans-first:99859.18 04:02:50 INFO - PROCESS | 9834 | Values: 423.3 425.4 429.8 439.7 440.8 18726.8 19222.0 19425.1 19480.7 19830.6 17370.6 17568.5 18899.1 19687.0 19687.6 4862.9 5237.7 5393.8 5637.3 5639.2 5839.2 5842.7 5869.1 5872.5 5881.0 5645.5 5836.9 5859.6 5879.2 5881.6 5876.7 5879.7 5894.4 5896.7 5908.3 5374.1 5384.1 5444.9 5712.8 5721.5 14040.4 14199.9 14329.1 21169.3 23431.5 2241.5 2278.7 2332.6 2375.6 2429.6 10362.1 10415.7 10430.9 10501.6 12572.4 2025.8 2226.5 2295.8 2339.7 2420.9 91991.5 93843.0 97053.0 97384.0 98209.5 18715.5 18797.2 19017.0 19077.5 19320.2 34704.1 34882.0 34977.7 35119.0 35474.3 8628.0 8680.3 8694.0 8895.6 9182.8 8656.4 8996.2 9024.6 9041.6 9116.5 5075.4 5197.5 5208.0 5237.3 5242.6 2029.2 2081.7 2107.3 2110.4 2168.7 479.2 1085.7 1105.9 1108.6 1213.9 11750.0 12203.6 12232.2 12240.8 12335.4 483.0 491.5 494.7 500.4 503.6 6432.7 6527.4 6576.8 6580.5 6655.6 559006.0 571478.0 622748.0 629491.0 633677.0 101376.0 105513.0 106631.5 106920.0 107248.5 506.6 511.3 514.5 515.9 516.5 11195.6 11284.1 11532.8 11545.8 11710.8 37943.4 38375.8 38852.0 39666.6 40463.4 60009.4 63918.7 64094.4 64364.4 64457.7 8846.2 12061.8 12507.2 13188.4 13296.9 13525.9 13541.2 13934.7 13994.9 14156.5 12441.6 12726.7 13142.1 13327.5 13622.9 8355.6 8574.6 8680.0 8696.3 8930.2 8523.6 9078.5 9174.7 9196.1 9726.5 12853.4 12878.7 12890.1 12916.9 12922.6 12259.8 12417.6 12509.4 12512.6 12706.6 04:02:50 INFO - PROCESS | 9834 | 04:02:50 INFO - PROCESS | 9834 | [#3] mootools.html Cycles:180 Average:5650.16 Median:4891.41 stddev:3113.41 (63.7%) stddev-sans-first:3105.56 04:02:50 INFO - PROCESS | 9834 | Values: 1373.9 1551.2 1555.0 1764.3 1866.7 8146.1 8283.0 8310.0 8332.7 8335.2 8122.6 8280.8 8312.8 8314.8 8328.2 2400.1 2409.0 2423.6 2430.1 2430.5 2435.9 2460.5 2472.2 2481.1 2495.6 2358.8 2390.9 2393.8 2394.5 2410.8 2412.2 2437.7 2456.7 2457.3 2458.9 2373.5 2450.7 2456.2 2470.3 2490.3 7445.4 7594.4 8473.2 8527.8 8541.0 5103.4 5191.3 5192.5 5194.9 5195.3 3494.8 3501.8 3574.1 3583.2 3619.3 1125.4 1130.9 1131.9 1151.3 1153.0 11554.9 11666.1 11669.6 12032.9 12078.9 4501.2 4511.9 4587.7 4588.8 4610.1 10332.5 10389.8 10439.2 10442.2 10448.2 5290.1 5316.8 5327.0 5336.3 5340.0 4887.5 4889.2 4893.6 4895.5 4896.4 3781.2 4003.6 4021.3 4021.9 4050.2 1212.0 1237.0 1239.7 1255.5 1258.2 912.3 930.2 1083.1 1088.7 1098.1 6082.6 6102.6 6138.7 6196.3 6301.2 474.9 476.3 483.5 483.8 494.2 4064.7 4068.7 4145.5 4289.6 4294.6 10306.6 10428.2 10654.6 10674.6 10738.6 10292.3 10323.7 10403.1 10423.4 10424.2 7900.9 7911.9 8079.9 8086.1 8151.5 5664.1 5696.4 5744.9 5810.6 5876.2 9058.6 9082.1 9304.3 9329.7 9588.4 9160.2 9338.8 9367.7 9421.1 9450.6 7459.1 7501.0 7520.1 7584.1 7588.0 8114.2 8149.2 8154.8 8187.4 8217.7 7222.1 7383.0 7574.7 7653.8 7730.8 7429.2 7510.5 7518.2 7590.0 7608.7 6976.9 6977.6 6980.9 7008.5 7019.5 4410.5 4998.7 5137.8 5239.7 5268.7 4782.6 4926.8 4964.4 5012.5 5063.9 04:02:50 INFO - PROCESS | 9834 | 04:02:50 INFO - PROCESS | 9834 | [#4] prototype.html Cycles:180 Average:5701.08 Median:6478.84 stddev:1714.15 (26.5%) stddev-sans-first:1671.31 04:02:50 INFO - PROCESS | 9834 | Values: 354.0 363.1 364.2 366.6 367.2 6240.9 6333.7 6401.3 6428.1 6476.3 6294.5 6370.4 6420.9 6425.6 6468.0 4943.6 4959.4 4966.1 4966.5 4971.6 4711.9 4778.0 4920.8 4960.6 4966.6 4897.4 4906.0 4907.0 4913.6 4916.9 4884.7 4888.4 4889.3 4903.2 4921.4 4298.5 4310.7 4328.4 4336.7 4339.6 6161.2 6181.4 6182.8 6188.4 6208.8 5582.7 5707.1 5714.3 5714.7 5723.0 6717.4 6744.7 6745.5 6745.5 6747.1 4791.2 4795.1 4799.5 4801.3 4803.9 7048.3 7051.5 7055.0 7056.6 7068.1 4906.9 4909.7 4916.7 4919.5 4919.5 4570.2 4739.3 4977.3 4985.0 4995.1 5518.3 5541.3 5545.2 5551.4 5554.3 6771.7 6788.9 6792.0 6807.8 6811.0 1621.5 1717.6 1754.2 1760.7 1770.2 1163.7 1178.0 1189.3 1193.9 1195.4 6431.1 6481.4 6484.9 6485.8 6503.2 6934.7 6957.9 6961.1 6988.4 6989.9 6482.3 6484.9 6489.6 6496.4 6497.7 3732.4 3763.3 3765.1 3767.8 3772.4 6991.4 7292.3 7316.0 7345.3 7351.4 7219.7 7235.0 7237.2 7253.4 7260.0 7303.6 7305.6 7311.2 7314.3 7321.7 6936.7 7070.2 7081.1 7084.4 7095.6 6938.7 6974.1 6975.7 6977.3 6983.4 7241.0 7270.0 7279.4 7307.6 7308.0 4772.5 4826.0 4826.5 4827.1 4845.1 6793.9 6815.7 7043.0 7050.0 7054.9 6829.2 6841.0 6863.9 6864.1 6871.6 6835.5 6835.9 6858.7 6867.0 6871.0 6729.6 6742.2 6754.3 6758.5 6759.0 6740.3 6899.1 6903.6 6912.5 6918.5 6736.1 6752.3 6758.7 6760.6 6763.5 04:02:50 INFO - PROCESS | 9834 | 04:02:50 INFO - PROCESS | 9834 | [#5] yui.html Cycles:180 Average:15661.88 Median:25796.01 stddev:17699.01 (68.6%) stddev-sans-first:17713.46 04:02:50 INFO - PROCESS | 9834 | Values: 798.2 801.6 844.8 923.3 923.6 15257.9 16551.8 16753.4 16774.1 16775.6 15176.9 15215.7 15257.2 15286.2 15324.2 784.1 924.6 931.7 945.2 949.0 930.1 933.1 938.7 939.0 939.8 966.0 973.2 976.9 977.5 977.8 826.3 965.3 969.0 979.6 979.8 713.1 713.7 713.9 714.3 714.3 15243.4 15268.7 15301.5 15303.3 15317.6 14192.9 14568.1 14739.4 14808.4 15393.3 12202.7 12236.2 12291.1 12324.8 12362.0 4014.2 4048.4 4113.2 4114.4 4138.1 57312.7 57380.4 57420.7 57500.7 57536.0 11678.9 11874.5 11943.6 11943.9 12013.3 22036.8 22067.1 22078.1 22102.3 22143.9 8665.0 8742.0 8811.0 8870.2 9161.2 4892.0 4910.1 4912.8 4913.4 4938.1 3375.1 3403.6 3409.9 3413.2 3416.9 567.5 587.1 608.5 651.2 670.2 691.5 706.4 711.8 755.7 783.4 9399.5 9473.7 9493.5 9514.1 9738.3 637.1 637.5 658.6 701.2 741.5 4554.2 4565.0 4590.5 4706.7 4783.1 63357.0 63492.0 64016.0 64531.4 64538.4 56560.0 57558.7 57614.0 57749.4 57768.4 47001.5 48675.0 49855.8 51511.2 51696.4 9145.5 9160.8 9203.9 9287.2 9289.3 38025.6 38517.0 39528.0 39608.4 39670.8 43515.3 43931.0 44382.8 48027.5 49039.0 12889.8 12928.6 13017.5 13216.4 13292.3 13994.8 14093.4 14403.9 14850.5 14958.3 11565.6 13477.5 13806.0 13858.8 14205.4 13297.3 13482.8 13559.8 13997.9 14340.0 12885.2 13109.4 13111.2 13362.3 13426.5 11000.2 11238.3 11242.0 11403.2 11559.9 10996.3 11214.2 11236.4 11514.3 11527.1 04:02:50 INFO - PROCESS | 9834 | -------- Summary: end -------- 04:02:50 INFO - PROCESS | 9834 | 04:02:51 INFO - TEST-INFO | 9834: exit 0 04:02:51 INFO - TEST-OK | dromaeo_css | took 1110063ms 04:02:51 INFO - TEST-START | kraken 04:02:51 INFO - operating with platform_type : linux_ 04:02:51 INFO - Initialising browser for kraken test... 04:02:51 INFO - TEST-INFO | started process 10026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmzunJ/profile http://localhost:38897/getInfo.html) 04:02:54 INFO - PROCESS | 10026 | __metrics Screen width/height:1600/1200 04:02:54 INFO - PROCESS | 10026 | colorDepth:24 04:02:54 INFO - PROCESS | 10026 | Browser inner width/height: 1024/697 04:02:54 INFO - PROCESS | 10026 | __metrics 04:02:55 ERROR - PROCESS | 10026 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:02:56 INFO - TEST-INFO | 10026: exit 0 04:02:56 INFO - Browser initialized. 04:02:56 INFO - Running cycle 1/1 for kraken test... 04:02:56 INFO - TEST-INFO | started process 10121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmzunJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:07 INFO - PROCESS | 10121 | RSS: Main: 141082624 04:03:07 INFO - PROCESS | 10121 | 04:03:10 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38897/tests/kraken/driver.html?testName=audio-beat-detection) 04:03:10 INFO - PROCESS | 10121 | RSS: Main: 197341184 04:03:10 INFO - PROCESS | 10121 | 04:03:13 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38897/tests/kraken/driver.html?testName=audio-dft) 04:03:14 INFO - PROCESS | 10121 | RSS: Main: 183250944 04:03:14 INFO - PROCESS | 10121 | 04:03:16 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38897/tests/kraken/driver.html?testName=audio-fft) 04:03:17 INFO - PROCESS | 10121 | RSS: Main: 272904192 04:03:17 INFO - PROCESS | 10121 | 04:03:19 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38897/tests/kraken/driver.html?testName=audio-oscillator) 04:03:20 INFO - PROCESS | 10121 | RSS: Main: 179847168 04:03:20 INFO - PROCESS | 10121 | 04:03:22 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38897/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:03:23 INFO - PROCESS | 10121 | RSS: Main: 178225152 04:03:23 INFO - PROCESS | 10121 | 04:03:25 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38897/tests/kraken/driver.html?testName=imaging-darkroom) 04:03:26 INFO - PROCESS | 10121 | RSS: Main: 212316160 04:03:26 INFO - PROCESS | 10121 | 04:03:29 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38897/tests/kraken/driver.html?testName=imaging-desaturate) 04:03:30 INFO - PROCESS | 10121 | RSS: Main: 212279296 04:03:30 INFO - PROCESS | 10121 | 04:03:33 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38897/tests/kraken/driver.html?testName=json-parse-financial) 04:03:33 INFO - PROCESS | 10121 | RSS: Main: 211853312 04:03:33 INFO - PROCESS | 10121 | 04:03:35 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38897/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:03:35 INFO - PROCESS | 10121 | RSS: Main: 191881216 04:03:35 INFO - PROCESS | 10121 | 04:03:37 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38897/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:03:38 INFO - PROCESS | 10121 | RSS: Main: 197636096 04:03:38 INFO - PROCESS | 10121 | 04:03:40 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38897/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:03:40 INFO - PROCESS | 10121 | RSS: Main: 210767872 04:03:40 INFO - PROCESS | 10121 | 04:03:43 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:03:43 INFO - PROCESS | 10121 | RSS: Main: 218214400 04:03:43 INFO - PROCESS | 10121 | 04:03:46 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:03:47 INFO - PROCESS | 10121 | RSS: Main: 214237184 04:03:47 INFO - PROCESS | 10121 | 04:03:48 INFO - PROCESS | 10121 | Cycle 1(1): loaded http://localhost:38897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38897/tests/kraken/driver.html?testName=ai-astar) 04:03:49 INFO - PROCESS | 10121 | RSS: Main: 274874368 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | __start_tp_report 04:03:49 INFO - PROCESS | 10121 | _x_x_mozilla_page_load 04:03:49 INFO - PROCESS | 10121 | _x_x_mozilla_page_load_details 04:03:49 INFO - PROCESS | 10121 | |i|pagename|runs| 04:03:49 INFO - PROCESS | 10121 | |0;ai-astar;113;113;110;111;112;110;106;112;109;108 04:03:49 INFO - PROCESS | 10121 | |1;audio-beat-detection;151;126;153;175;125;158;154;133;187;125 04:03:49 INFO - PROCESS | 10121 | |2;audio-dft;162;160;161;160;161;160;160;162;160;162 04:03:49 INFO - PROCESS | 10121 | |3;audio-fft;78;74;76;185;76;76;76;74;170;76 04:03:49 INFO - PROCESS | 10121 | |4;audio-oscillator;91;92;156;92;92;91;160;92;91;145 04:03:49 INFO - PROCESS | 10121 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;116;116 04:03:49 INFO - PROCESS | 10121 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;145 04:03:49 INFO - PROCESS | 10121 | |7;imaging-desaturate;94;94;94;95;94;94;94;95;95;95 04:03:49 INFO - PROCESS | 10121 | |8;json-parse-financial;56;54;54;55;54;56;55;76;53;52 04:03:49 INFO - PROCESS | 10121 | |9;json-stringify-tinderbox;60;61;60;60;61;60;60;61;60;60 04:03:49 INFO - PROCESS | 10121 | |10;stanford-crypto-aes;73;72;72;72;73;73;82;81;73;73 04:03:49 INFO - PROCESS | 10121 | |11;stanford-crypto-ccm;113;116;114;115;110;110;110;119;134;126 04:03:49 INFO - PROCESS | 10121 | |12;stanford-crypto-pbkdf2;160;157;159;157;159;164;157;158;162;158 04:03:49 INFO - PROCESS | 10121 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;66;68;66;68;69 04:03:49 INFO - PROCESS | 10121 | __end_tp_report 04:03:49 INFO - PROCESS | 10121 | __start_cc_report 04:03:49 INFO - PROCESS | 10121 | _x_x_mozilla_cycle_collect,1602 04:03:49 INFO - PROCESS | 10121 | __end_cc_report 04:03:49 INFO - PROCESS | 10121 | __startTimestamp1465815829001__endTimestamp 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | ------- Summary: start ------- 04:03:49 INFO - PROCESS | 10121 | Number of tests: 14 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:2.27 (2.0%) stddev-sans-first:2.20 04:03:49 INFO - PROCESS | 10121 | Values: 113.0 113.0 110.0 111.0 112.0 110.0 106.0 112.0 109.0 108.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:153.50 stddev:21.56 (14.0%) stddev-sans-first:22.85 04:03:49 INFO - PROCESS | 10121 | Values: 151.0 126.0 153.0 175.0 125.0 158.0 154.0 133.0 187.0 125.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 04:03:49 INFO - PROCESS | 10121 | Values: 162.0 160.0 161.0 160.0 161.0 160.0 160.0 162.0 160.0 162.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:43.06 (56.7%) stddev-sans-first:45.17 04:03:49 INFO - PROCESS | 10121 | Values: 78.0 74.0 76.0 185.0 76.0 76.0 76.0 74.0 170.0 76.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:91.50 stddev:30.22 (33.0%) stddev-sans-first:31.24 04:03:49 INFO - PROCESS | 10121 | Values: 91.0 92.0 156.0 92.0 92.0 91.0 160.0 92.0 91.0 145.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:03:49 INFO - PROCESS | 10121 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:03:49 INFO - PROCESS | 10121 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:03:49 INFO - PROCESS | 10121 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.00 stddev:6.96 (12.7%) stddev-sans-first:7.38 04:03:49 INFO - PROCESS | 10121 | Values: 56.0 54.0 54.0 55.0 54.0 56.0 55.0 76.0 53.0 52.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:03:49 INFO - PROCESS | 10121 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 60.0 61.0 60.0 60.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:73.00 stddev:3.78 (5.2%) stddev-sans-first:3.97 04:03:49 INFO - PROCESS | 10121 | Values: 73.0 72.0 72.0 72.0 73.0 73.0 82.0 81.0 73.0 73.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:115.50 stddev:7.82 (6.8%) stddev-sans-first:8.18 04:03:49 INFO - PROCESS | 10121 | Values: 113.0 116.0 114.0 115.0 110.0 110.0 110.0 119.0 134.0 126.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.00 stddev:2.33 (1.5%) stddev-sans-first:2.45 04:03:49 INFO - PROCESS | 10121 | Values: 160.0 157.0 159.0 157.0 159.0 164.0 157.0 158.0 162.0 158.0 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - PROCESS | 10121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 04:03:49 INFO - PROCESS | 10121 | Values: 67.0 67.0 67.0 66.0 67.0 66.0 68.0 66.0 68.0 69.0 04:03:49 INFO - PROCESS | 10121 | -------- Summary: end -------- 04:03:49 INFO - PROCESS | 10121 | 04:03:49 INFO - TEST-INFO | 10121: exit 0 04:03:49 INFO - TEST-OK | kraken | took 58795ms 04:03:49 INFO - SUITE-END | took 1168s 04:03:50 INFO - Completed test suite (00:19:29) 04:03:50 INFO - javascript benchmark 04:03:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3240.1251662051245, 3300.12546675131, 3313.2545177335087, 3345.1135449105977, 3357.0264623259254, 5444.537214336781, 5466.070767969445, 5466.28938238029, 5472.890542189164, 5493.752781124854, 5442.12925931851, 5449.04641687705, 5470.316210473691, 5475.890482190353, 5511.0, 4980.900381992367, 5015.473375295596, 5033.320501732256, 5054.090263752523, 5105.489451054883, 5036.445990940993, 5069.062223488648, 5074.441811400743, 5119.923201151967, 5140.948590514085, 5063.46833582474, 5102.489751024887, 5104.515071068261, 5105.923411148836, 5134.974325128369, 5011.423686276088, 5040.747962601855, 5092.84721458355, 5095.668781529207, 5102.413222479426, 4926.950730492685, 4950.603951683893, 5009.373828271466, 5018.121828679967, 5044.066847633163, 5373.032854086263, 5392.514673679388, 5399.865003374908, 5402.837914862561, 5420.972895135538, 5732.684702341369, 5838.182654428383, 5855.707214639294, 5855.882882342372, 5892.616979896293, 5972.880542389172, 6044.395560443964, 6049.032154855202, 6074.5747797654185, 6080.817575472743, 5494.725263736797, 5495.780168793243, 5500.202470641734, 5511.311086114236, 5543.473370029841, 5948.315943666534, 5965.582409231399, 5967.224260846149, 5996.790112346047, 5999.700014999233, 5753.194552762617, 5758.0787074068785, 5763.308402991668, 5765.279340082489, 5792.565557583198, 5831.358550559435, 5844.211031510692, 5845.123231515222, 5845.824625261249, 5845.853853653693, 5705.372409035002, 5788.0449725795615, 5802.738876750556, 5825.854353641193, 5910.763569457259, 5904.5571582131515, 5907.350191478934, 5908.379620139909, 5914.319853216849, 5915.3788852170765, 4406.735595864258, 4495.033567782943, 4503.819847206075, 4524.547545245515, 4527.932081018787, 3980.3631418972827, 3997.2205419942834, 4032.213718324957, 4059.878203653895, 4069.104796944667, 5570.777168913198, 5584.972075139598, 5593.105103183471, 5600.6919619420505, 5643.830685079454, 5797.333306669702, 5926.2295901532525, 5937.643741375531, 5939.940600594025, 5945.108233764883, 5553.111502159716, 5575.080111781511, 5583.804566840141, 5594.860128496739, 5614.775408983595, 5087.796488140507, 5097.158968770112, 5100.744962751922, 5103.464136265713, 5124.92312615311, 5916.230889984275, 6076.726547305293, 6108.969455152785, 6116.816495505142, 6120.0, 5906.26171728534, 5911.615744976562, 5927.525797936069, 5934.287885453773, 5940.049592065248, 6090.634561926121, 6109.450149486567, 6112.786052488142, 6112.816615501542, 6115.7247923844425, 5683.5453163747625, 5807.535397168132, 5809.854753631024, 5824.126381042877, 5828.883422331445, 5857.824265272048, 5906.940930590639, 5916.674582897982, 5921.348651648402, 5951.851203719942, 5732.828015159552, 5763.596548241583, 5766.423357664368, 5770.596058276048, 5780.219670344618, 5582.0, 5734.59857809966, 5740.454656807597, 5753.1370294456165, 5814.5348372130975, 5630.831075067755, 5632.887342253214, 5637.267155269788, 5655.095184770417, 5661.773529058792, 5705.7147142643535, 5739.540836733135, 5761.5390768739235, 5762.481376676119, 5764.308283006066, 5573.3869274380595, 5617.606767526234, 5641.576881733969, 5662.546996240373, 5672.688002159921], "value": 5435.705081872956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.0956689335611, 668.5086461450836, 673.8517526144248, 683.0744341417376, 748.3863232149638, 33306.50040249395, 33927.15182120448, 40506.7974660127, 41102.58897411025, 41146.38280425796, 43293.35059974103, 43396.783016084875, 43899.0, 43920.78039609797, 43951.340729889074, 7782.0, 8742.082081381459, 8909.643614255454, 8910.688125915594, 8918.152775486318, 10629.096526795232, 10914.563417463292, 10920.563177472892, 10924.781504369908, 10925.617603383884, 10531.473426328692, 10549.68350949469, 10636.46817659114, 10637.255392122555, 10646.041856232938, 10484.63303784364, 10485.213608979318, 10551.525181366856, 10563.947180264126, 10565.366078035266, 10398.0, 10513.053825155695, 10514.737131571772, 10520.263581549294, 10532.210084243636, 45132.77433612811, 45548.3167752484, 45551.77224113891, 45655.08689826185, 45694.77152614249, 3825.5218097737784, 3849.8845034649007, 3998.7000974926705, 4143.6685065194715, 4524.547545245482, 33301.33397332064, 33513.0, 33775.6622433775, 33785.32429351424, 33822.83088584541, 4249.3625956106525, 4330.458692663417, 4357.9128417431475, 4401.801918913657, 4414.977925110386, 250681.0, 251951.0, 252774.0, 252819.0, 253424.0, 62547.0, 63387.36612633907, 63398.6830065856, 63473.36526634767, 63755.0, 66620.33379666142, 71124.64437677778, 71627.0, 71802.28197717956, 72024.63987680028, 18853.24587016504, 18906.62186756257, 18933.715994260096, 18938.337158199396, 18947.526311842314, 13195.868041319463, 14097.083689560352, 15304.38782448712, 15400.22998850053, 15570.9221453892, 19863.205471780966, 20090.698639520127, 20160.49598760043, 20162.0, 20169.0, 7143.24995875436, 7413.777586672409, 7470.103587569418, 7522.6614802334025, 7570.0, 1118.2731224704007, 1124.7244425115734, 1150.6605551362368, 1180.3213152437384, 1193.1707463312914, 33924.58323362824, 34023.489647655304, 34043.0, 34354.31291374158, 34492.0, 1221.4930803716359, 1246.6447062587301, 1274.4710944957924, 1291.651254161371, 1341.926194059336, 17301.221445035004, 17975.82031133576, 18022.639547209244, 18187.363442279457, 18194.4340446774, 499225.0, 499596.0, 502448.0, 504213.0, 504868.0, 62241.377586224466, 62585.68707156435, 62903.685481573215, 62958.370416296166, 62977.68511157415, 1369.9520516782063, 1477.121112937779, 1490.2027415332745, 1515.5907904865624, 1617.9757303640454, 30081.398372032876, 31514.212144696565, 31855.522167167048, 31998.0, 32592.837035814668, 49389.25916111189, 50149.0, 50190.247146293565, 50256.74871625618, 50322.7483862593, 324100.0, 324149.0, 325171.0, 326394.0, 327510.0, 26874.0, 27405.31486712848, 30264.394712106074, 30661.080167595006, 30885.536716949715, 43656.78171609122, 44214.778926105166, 45230.773846130556, 45495.31757023714, 45656.31515527203, 35292.647073529966, 37484.0, 38632.0, 39236.21527569376, 40374.798126009184, 38792.22415551617, 40235.1952960945, 40779.7961010193, 40827.38758918678, 42093.78953105215, 42473.787631062885, 45048.77475612732, 45652.54347456483, 46514.0, 46629.53370466252, 36000.81999589985, 36619.45070823993, 37210.813945930095, 37305.0, 38400.80799595984, 29064.56403153912, 29467.0, 29538.261543461584, 29753.10740677783, 29816.552751708306], "value": 20928.382069182346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.32057048437247, 425.4235510882756, 429.8474041715193, 439.72517176764524, 440.7994362565033, 18726.812731872677, 19222.0, 19425.12586933588, 19480.70778938317, 19830.60338793223, 17370.56573585661, 17568.472945811613, 18899.149538270776, 19687.0, 19687.606247875035, 4862.927056094161, 5237.7381130943395, 5393.78424863005, 5637.295338082739, 5639.210510528529, 5839.240898683165, 5842.707864606774, 5869.06095024794, 5872.500837428824, 5881.029630111048, 5645.463680950324, 5836.883262334751, 5859.619124756899, 5879.235699359077, 5881.558883083786, 5876.706164691748, 5879.735411906453, 5894.351621321694, 5896.734646940855, 5908.291005079396, 5374.059539580558, 5384.084705600018, 5444.945550544483, 5712.828615141552, 5721.4850663440075, 14040.438382464688, 14199.929000354932, 14329.140251584835, 21169.259075932423, 23431.53136937252, 2241.540484200735, 2278.669592909019, 2332.6151185054446, 2375.5842727522613, 2429.6234083717054, 10362.119219866321, 10415.739606509822, 10430.947845260802, 10501.632442864464, 12572.371381430983, 2025.8379329653592, 2226.476777957179, 2295.827812914038, 2339.660749191358, 2420.9273721788372, 91991.54004229936, 93843.0, 97053.0, 97384.0, 98209.5089524555, 18715.532111697317, 18797.15412806427, 19017.00321466226, 19077.523061923563, 19320.227190912487, 34704.132396689776, 34881.9535413938, 34977.65022349795, 35119.0, 35474.29051418957, 8627.95686021566, 8680.348973826862, 8694.0, 8895.555222238992, 9182.77043073915, 8656.394052416397, 8996.190342869042, 9024.593893274818, 9041.63833446668, 9116.49859257734, 5075.365579302587, 5197.506236907488, 5208.036513244986, 5237.292965449692, 5242.633015688942, 2029.2288930206428, 2081.6669332906963, 2107.262458139639, 2110.366889933014, 2168.6638571021517, 479.2284422080448, 1085.6634443322437, 1105.9447027648746, 1108.6286094158386, 1213.919611545725, 11750.0, 12203.633890983285, 12232.204906681038, 12240.81638775419, 12335.444904979298, 482.96860704054126, 491.46675856695884, 494.6619394537839, 500.412015881338, 503.5669324381029, 6432.678366081677, 6527.379898909596, 6576.769813056616, 6580.473562115019, 6655.600663960178, 559006.0, 571478.0, 622748.0, 629491.0, 633677.0, 101376.0, 105513.0, 106631.4668426653, 106920.0, 107248.46375768071, 506.6453482562221, 511.3276042004752, 514.5471984653481, 515.9019786240602, 516.4757770862652, 11195.60815371458, 11284.097272218367, 11532.82700759506, 11545.769084618092, 11710.765784684429, 37943.430848536744, 38375.80812095922, 38852.0, 39666.60333396629, 40463.393049104874, 60009.39990600213, 63918.68040659767, 64094.35905641071, 64364.356356435834, 64457.67771161114, 8846.248068914214, 12061.81907271374, 12507.187032842836, 13188.449984755627, 13296.86703132995, 13525.864741352461, 13541.187528748307, 13934.71691516204, 13994.860051399355, 14156.50452234167, 12441.564545241235, 12726.68183295425, 13142.145760525918, 13327.533536326182, 13622.86377136216, 8355.623996920274, 8574.571271436278, 8679.956600216958, 8696.304295656459, 8930.240929521064, 8523.573821309034, 9078.500682462263, 9174.724758257264, 9196.08039196075, 9726.513674316115, 12853.357332133543, 12878.678033048875, 12890.09769316139, 12916.870831291943, 12922.612321630366, 12259.816102758645, 12417.565385211474, 12509.374531273583, 12512.562060327844, 12706.618801435972], "value": 9207.424076383604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.924434156121, 1551.239892452698, 1554.9533513994581, 1764.2501936676917, 1866.7479890214818, 8146.144654811241, 8282.958585207072, 8310.002799664033, 8332.66669333226, 8335.208155225258, 8122.634481448335, 8280.792980175484, 8312.833743325129, 8314.750557483285, 8328.20882016209, 2400.0999625140616, 2408.95182096358, 2423.5516429460517, 2430.0887167312258, 2430.501747141832, 2435.902563897442, 2460.520198561281, 2472.171822439485, 2481.131603938616, 2495.563276426618, 2358.79950204232, 2390.9043638254448, 2393.7725916038034, 2394.5330660521204, 2410.770976757205, 2412.16780210827, 2437.744036876129, 2456.7297597264287, 2457.3242358351417, 2458.864762438065, 2373.4896997145697, 2450.656908032877, 2456.152627343564, 2470.2712699753615, 2490.302715239736, 7445.404367650629, 7594.354479869163, 8473.195046470575, 8527.786805329853, 8541.017782954916, 5103.387593488805, 5191.299174611417, 5192.480751924815, 5194.870128246824, 5195.298634684307, 3494.842732077037, 3501.8249087545773, 3574.070741607175, 3583.1937813991644, 3619.2580520993133, 1125.352922069813, 1130.8586426696663, 1131.903788178006, 1151.2862025544132, 1153.0199330569033, 11554.884451155549, 11666.125040621988, 11669.649910502698, 12032.939835300855, 12078.879211207863, 4501.167284052395, 4511.887202819956, 4587.747673877969, 4588.839390621312, 4610.077984403066, 10332.483375831178, 10389.792204155874, 10439.217058720626, 10442.164626829835, 10448.164146868232, 5290.100682883919, 5316.787328506894, 5327.0, 5336.306280183551, 5339.973300133474, 4887.486813884562, 4889.193283108319, 4893.6329775266995, 4895.510448955147, 4896.387951506062, 3781.1870447853844, 4003.579624139482, 4021.2761702893176, 4021.8994525137105, 4050.210209009274, 1212.0485418946084, 1236.9567065152855, 1239.7396546725108, 1255.5417272695584, 1258.2261908925946, 912.3431129586687, 930.1907340613709, 1083.0739717541546, 1088.7278180454887, 1098.1269890437122, 6082.574219804571, 6102.611782604964, 6138.7237574309265, 6196.318404975449, 6301.243850737849, 474.89077512172395, 476.3474040564449, 483.4802587218754, 483.84033269021137, 494.1821285772053, 4064.695147863922, 4068.6948478864206, 4145.523264824584, 4289.613934745826, 4294.613484786384, 10306.639267625596, 10428.217883658755, 10654.62708805188, 10674.57301707923, 10738.624148154777, 10292.279540432099, 10323.741906452398, 10403.063724264852, 10423.374597524173, 10424.166066714644, 7900.881486777703, 7911.920880791118, 8079.949606551111, 8086.070101938352, 8151.470154439942, 5664.122061080539, 5696.430356964271, 5744.885102297847, 5810.622309549865, 5876.236089308362, 9058.637654493747, 9082.091790820865, 9304.302177336862, 9329.673461428818, 9588.37675551087, 9160.175584197454, 9338.813223735624, 9367.718968430958, 9421.057894210524, 9450.574724137568, 7459.104907411145, 7500.962495187489, 7520.059992500937, 7584.127825300161, 7587.962060189664, 8114.188581141839, 8149.225823546753, 8154.836903261783, 8187.385946053951, 8217.712380066669, 7222.09723784527, 7383.040204773345, 7574.734884279023, 7653.808654783452, 7730.845383092194, 7429.182789893215, 7510.47426680149, 7518.210587888193, 7590.0, 7608.733694320672, 6976.930230697831, 6977.581345119309, 6980.860382792214, 7008.474364422791, 7019.508634395747, 4410.470743510799, 4998.725070121178, 5137.8201762938115, 5239.685618862881, 5268.6575372600655, 4782.593479554277, 4926.827561035347, 4964.379452568429, 5012.523810238022, 5063.87340316495], "value": 4522.212075655182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.9964600353996, 363.10675737685295, 364.2023967511152, 366.58026559589257, 367.24531088612906, 6240.875182496358, 6333.651649159295, 6401.295857455676, 6428.1000659907595, 6476.287608363088, 6294.464970477515, 6370.394812492817, 6420.903686444695, 6425.614463132215, 6468.029795530672, 4943.579795717359, 4959.355283813099, 4966.056449274644, 4966.478519755427, 4971.577415919651, 4711.929321060187, 4777.952220477786, 4920.8277710280145, 4960.627952903528, 4966.627502937276, 4897.4123105227245, 4905.975470122645, 4907.0, 4913.606911447094, 4916.877078073041, 4884.682495637772, 4888.364512613373, 4889.3399391082285, 4903.215485522299, 4921.360223171001, 4298.527162012176, 4310.655147588185, 4328.372386004044, 4336.718113322656, 4339.587739164775, 6161.229846269216, 6181.3818618138275, 6182.814515564541, 6188.412100850412, 6208.813735587894, 5582.665040097567, 5707.14392841073, 5714.285714285715, 5714.685692286923, 5723.0, 6717.42901853343, 6744.662766861687, 6745.527813053088, 6745.527813053088, 6747.05541224229, 4791.209450440673, 4795.064962332347, 4799.472058073609, 4801.303810947393, 4803.9039219215765, 7048.259932707043, 7051.506394552383, 7054.999999999949, 7056.611886346249, 7068.11648543932, 4906.852794416173, 4909.656324057353, 4916.729579873141, 4919.458859525449, 4919.540229885058, 4570.154521413549, 4739.289106634033, 4977.32806071183, 4985.0, 4995.075910956485, 5518.255035570227, 5541.33503979525, 5545.195946587723, 5551.417101204396, 5554.333479982428, 6771.695273712695, 6788.932110678928, 6792.049113124167, 6807.829804254933, 6810.965945170243, 1621.5459671292058, 1717.5534361065963, 1754.2456743600374, 1760.6830770461183, 1770.2034084661955, 1163.7381589142544, 1177.9941100294443, 1189.2745425290566, 1193.8567371915426, 1195.3664557784389, 6431.067495213168, 6481.384268494486, 6484.935150648527, 6485.837854053686, 6503.154589903283, 6934.722611095601, 6957.9304206958295, 6961.129858767654, 6988.371046605728, 6989.93010069903, 6482.286948435668, 6484.935150648527, 6489.572294095292, 6496.382843629847, 6497.707603157869, 3732.42147467143, 3763.2661630981697, 3765.134019175605, 3767.773933563995, 3772.43413487979, 6991.440684745208, 7292.270772922665, 7316.0, 7345.338919497164, 7351.375133113638, 7219.711211551479, 7234.96382518084, 7237.203907570163, 7253.419726421874, 7260.0, 7303.59830209333, 7305.5981920994855, 7311.232320606367, 7314.26857314275, 7321.670524826395, 6936.653167341512, 7070.151581810215, 7081.114860642419, 7084.36240738336, 7095.574265544084, 6938.653067346511, 6974.093367862146, 6975.651217439209, 6977.33715297046, 6983.441324694114, 7240.963795181201, 7269.963650181715, 7279.381252593589, 7307.634618269171, 7308.04995350601, 4772.475027746876, 4825.9758701206265, 4826.517348265286, 4827.08285425768, 4845.079434907357, 6793.898091528532, 6815.727370905108, 7042.964785176041, 7049.9647501762165, 7054.894176587252, 6829.248782634006, 6841.0, 6863.897041544481, 6864.107666003388, 6871.553349032297, 6835.487338449736, 6835.863282734417, 6858.691358888762, 6867.0, 6871.03805467225, 6729.596224226562, 6742.157230346207, 6754.290799465985, 6758.459323254227, 6759.0, 6740.325967403221, 6899.103116594811, 6903.6203008835, 6912.516123871281, 6918.481113916577, 6736.090627765385, 6752.291009444134, 6758.662066896537, 6760.560563563353, 6763.526553141233], "value": 5145.88970902391, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.1539568057859, 801.5711594297048, 844.8437039147755, 923.3075193604794, 923.6351641101764, 15257.923710381447, 16551.834481655194, 16753.413630522933, 16774.07742574158, 16775.58061048473, 15176.924115379408, 15215.695686086272, 15257.237138143104, 15286.2356882156, 15324.233788310568, 784.1139512351064, 924.5977999570175, 931.7437704631213, 945.2201933404934, 949.0319873728793, 930.144267274106, 933.1228645073643, 938.6761567259284, 938.9859152112724, 939.8214339275515, 965.9661911833088, 973.1971123822839, 976.85835553845, 977.49170431376, 977.8386566216566, 826.3224156191925, 965.2663975378692, 969.0406497567428, 979.6032606794224, 979.7501637082498, 713.1050531582882, 713.6752777486231, 713.8607971445571, 714.2536049827942, 714.2821464428268, 15243.390264389522, 15268.694626107526, 15301.464448744351, 15303.311350989232, 15317.617059573487, 14192.9355298352, 14568.125912445286, 14739.410423583044, 14808.407663693439, 15393.307301171362, 12202.694932626666, 12236.204646698025, 12291.139620226588, 12324.81512777309, 12362.0, 4014.1770936957855, 4048.392741088831, 4113.1568028554075, 4114.362273847529, 4138.0689344897455, 57312.71343643297, 57380.42619573793, 57420.71289643525, 57500.71249643725, 57536.0, 11678.88321116795, 11874.465649045813, 11943.581974630846, 11943.88056119445, 12013.339266340436, 22036.779632203794, 22067.11731530753, 22078.11687532513, 22102.336929892128, 22143.889280553492, 8664.956675216583, 8741.956290218635, 8810.955945220232, 8870.246029087471, 9161.221296189766, 4891.951080489221, 4910.140725373046, 4912.754362281943, 4913.361263035782, 4938.135826230396, 3375.0549846043145, 3403.6256011838677, 3409.880654177092, 3413.197898493852, 3416.8804091857164, 567.5402923631789, 587.1310460518457, 608.4554323880103, 651.1697585578331, 670.2258890980925, 691.5021184747075, 706.4489698035541, 711.7544447165719, 755.7014979083341, 783.3576467296762, 9399.530023498797, 9473.715788526355, 9493.477858717699, 9514.137793707741, 9738.269629777795, 637.0985056145502, 637.4740838808002, 658.5883822610868, 701.1971292869636, 741.525423728814, 4554.157480866051, 4564.954350456519, 4590.495045544987, 4706.7411292378565, 4783.115123702126, 63357.0, 63492.0, 64016.0, 64531.35468645347, 64538.35461645418, 56560.0, 57558.7122064387, 57614.0, 57749.422505774404, 57768.422315776304, 47001.529984699715, 48675.02649947052, 49855.750721246884, 51511.22733159005, 51696.44910652687, 9145.45127292338, 9160.816783664157, 9203.86194207074, 9287.210587100171, 9289.303302252494, 38025.61974380331, 38517.0, 39528.0, 39608.40587391134, 39670.80164599159, 43515.34726979034, 43931.0, 44382.77808610936, 48027.5197248023, 49039.0, 12889.8066529004, 12928.612141635766, 13017.544385946447, 13216.405261763435, 13292.335383230993, 13994.790078148631, 14093.436262549383, 14403.92798036045, 14850.480233192218, 14958.32687529042, 11565.595204167814, 13477.528286509925, 13806.033577649468, 13858.792118118437, 14205.431782728576, 13297.26865022433, 13482.752932826128, 13559.796603050765, 13997.930010349883, 14339.996200265881, 12885.162464439782, 13109.410076546768, 13111.2133272004, 13362.331883405985, 13426.462941482232, 11000.22998390105, 11238.325700458, 11242.0, 11403.201775875608, 11559.942200288944, 10996.340219586851, 11214.15893807984, 11236.438178090899, 11514.251573647685, 11527.135464840003], "value": 7197.3503044430945, "unit": "score"}], "name": "dromaeo_css", "value": 7482.137302451215, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 110.0, 111.0, 112.0, 110.0, 106.0, 112.0, 109.0, 108.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 153.0, 175.0, 125.0, 158.0, 154.0, 133.0, 187.0, 125.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 160.0, 161.0, 160.0, 160.0, 162.0, 160.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 76.0, 185.0, 76.0, 76.0, 76.0, 74.0, 170.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 156.0, 92.0, 92.0, 91.0, 160.0, 92.0, 91.0, 145.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 55.0, 54.0, 56.0, 55.0, 76.0, 53.0, 52.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 73.0, 73.0, 82.0, 81.0, 73.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 114.0, 115.0, 110.0, 110.0, 110.0, 119.0, 134.0, 126.0], "value": 116.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 159.0, 157.0, 159.0, 164.0, 157.0, 158.0, 162.0, 158.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 68.0, 66.0, 68.0, 69.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1516.3, "alertThreshold": 2.0}]} 04:03:50 INFO - Return code: 0 04:03:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:03:50 ERROR - # TBPL SUCCESS # 04:03:50 INFO - Running post-action listener: _resource_record_post_action 04:03:50 INFO - Running post-run listener: _resource_record_post_run 04:03:51 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 151552; Write bytes: 215343104; Read time: 216; Write time: 105476 04:03:51 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 4677632; Read time: 0; Write time: 292 04:03:51 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 151552; Write bytes: 210128896; Read time: 216; Write time: 105184 04:03:51 INFO - Running post-run listener: _upload_blobber_files 04:03:51 INFO - Blob upload gear active. 04:03:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:03:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:03:51 INFO - (blobuploader) - INFO - Open directory for files ... 04:03:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:03:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:03:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:52 INFO - (blobuploader) - INFO - Done attempting. 04:03:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:03:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:03:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:53 INFO - (blobuploader) - INFO - Done attempting. 04:03:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:03:53 INFO - Return code: 0 04:03:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:03:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:03:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9edc3d14d0079be57def029a3b8f38726c69e8b35013189d8fd55d464a6d934c2b3be1251195bac9f5e70b175dbde6abe34596f46b86bbcddbff156768c77158", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/408c92ddf4ab5d65ebde1b266402696587d05731e911f0d07d92310ed9a4636ab554a50151e91dec95231b2082b441325b9aaca81ffa140d19b14f7d8dbaa8c5"} 04:03:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:03:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:03:53 INFO - Contents: 04:03:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9edc3d14d0079be57def029a3b8f38726c69e8b35013189d8fd55d464a6d934c2b3be1251195bac9f5e70b175dbde6abe34596f46b86bbcddbff156768c77158", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/408c92ddf4ab5d65ebde1b266402696587d05731e911f0d07d92310ed9a4636ab554a50151e91dec95231b2082b441325b9aaca81ffa140d19b14f7d8dbaa8c5"} 04:03:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:03:53 INFO - Copying logs to upload dir... 04:03:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:03:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.044243 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-13 04:03:53.103476) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 04:03:53.109080) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042 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/9edc3d14d0079be57def029a3b8f38726c69e8b35013189d8fd55d464a6d934c2b3be1251195bac9f5e70b175dbde6abe34596f46b86bbcddbff156768c77158", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/408c92ddf4ab5d65ebde1b266402696587d05731e911f0d07d92310ed9a4636ab554a50151e91dec95231b2082b441325b9aaca81ffa140d19b14f7d8dbaa8c5"} build_url:https://queue.taskcluster.net/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/e7_Sa5M9QJOUK8Y_F5Ndcw/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/9edc3d14d0079be57def029a3b8f38726c69e8b35013189d8fd55d464a6d934c2b3be1251195bac9f5e70b175dbde6abe34596f46b86bbcddbff156768c77158", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/408c92ddf4ab5d65ebde1b266402696587d05731e911f0d07d92310ed9a4636ab554a50151e91dec95231b2082b441325b9aaca81ffa140d19b14f7d8dbaa8c5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 04:03:53.138056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 04:03:53.138435) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465810281.466556-583163042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 04:03:53.217574) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 04:03:53.217902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 04:03:53.218196) ========= ========= Total master_lag: 0.15 =========