builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1467053062.7 results: success (0) buildid: 20160627090417 builduid: 3a21e602a97a4decaab302f291f79a16 revision: eacd3797afb7c4cea080a62274c3eb076fabe196 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:22.704446) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:22.705141) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:22.705575) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:22.767028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:22.767549) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 11:44:23-- 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% 38.7M=0s 2016-06-27 11:44:23 (38.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072739 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:22.855006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:22.855401) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017260 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:22.905447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:22.905806) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev eacd3797afb7c4cea080a62274c3eb076fabe196 --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 eacd3797afb7c4cea080a62274c3eb076fabe196 --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=97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 11:44:23,449 truncating revision to first 12 chars 2016-06-27 11:44:23,449 Setting DEBUG logging. 2016-06-27 11:44:23,449 attempt 1/10 2016-06-27 11:44:23,449 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/eacd3797afb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 11:44:23,728 unpacking tar archive at: mozilla-beta-eacd3797afb7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617888 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:23.569751) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:23.570088) ========= script_repo_revision: eacd3797afb7c4cea080a62274c3eb076fabe196 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:23.570551) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:23.571151) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 11:44:23.581750) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-27 11:44:23.582185) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:44:24 INFO - MultiFileLogger online at 20160627 11:44:24 in /builds/slave/test 11:44:24 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 11:44:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:44:24 INFO - {'append_to_log': False, 11:44:24 INFO - 'base_work_dir': '/builds/slave/test', 11:44:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:44:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:44:24 INFO - 'branch': 'Mozilla-Beta', 11:44:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:44:24 INFO - 'config_files': ('talos/linux_config.py',), 11:44:24 INFO - 'default_actions': ('clobber', 11:44:24 INFO - 'read-buildbot-config', 11:44:24 INFO - 'download-and-extract', 11:44:24 INFO - 'populate-webroot', 11:44:24 INFO - 'create-virtualenv', 11:44:24 INFO - 'install', 11:44:24 INFO - 'run-tests'), 11:44:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:44:24 INFO - 'download_minidump_stackwalk': True, 11:44:24 INFO - 'download_symbols': 'ondemand', 11:44:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:44:24 INFO - 'tooltool.py': '/tools/tooltool.py', 11:44:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:44:24 INFO - '/tools/misc-python/virtualenv.py')}, 11:44:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:44:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:44:24 INFO - 'installer_path': 'installer.exe', 11:44:24 INFO - 'log_level': 'info', 11:44:24 INFO - 'log_name': 'talos', 11:44:24 INFO - 'log_to_console': True, 11:44:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:44:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:44:24 INFO - 'opt_config_files': (), 11:44:24 INFO - 'pip_index': False, 11:44:24 INFO - 'sps_profile': False, 11:44:24 INFO - 'sps_profile_interval': 0, 11:44:24 INFO - 'suite': 'dromaeojs', 11:44:24 INFO - 'system_bits': '32', 11:44:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:44:24 INFO - 'title': 'talos-linux64-ix-068', 11:44:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:44:24 INFO - 'use_talos_json': True, 11:44:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:44:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:44:24 INFO - 'work_dir': 'build'} 11:44:24 INFO - ##### 11:44:24 INFO - ##### Running clobber step. 11:44:24 INFO - ##### 11:44:24 INFO - Running pre-action listener: _resource_record_pre_action 11:44:24 INFO - Running main action method: clobber 11:44:24 INFO - rmtree: /builds/slave/test/build 11:44:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:44:24 INFO - Running post-action listener: _resource_record_post_action 11:44:24 INFO - ##### 11:44:24 INFO - ##### Running read-buildbot-config step. 11:44:24 INFO - ##### 11:44:24 INFO - Running pre-action listener: _resource_record_pre_action 11:44:24 INFO - Running main action method: read_buildbot_config 11:44:24 INFO - Using buildbot properties: 11:44:24 INFO - { 11:44:24 INFO - "project": "", 11:44:24 INFO - "product": "firefox", 11:44:24 INFO - "script_repo_revision": "production", 11:44:24 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:44:24 INFO - "repository": "", 11:44:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:44:24 INFO - "buildid": "20160627090417", 11:44:24 INFO - "pgo_build": "True", 11:44:24 INFO - "basedir": "/builds/slave/test", 11:44:24 INFO - "buildnumber": 138, 11:44:24 INFO - "slavename": "talos-linux64-ix-068", 11:44:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:44:24 INFO - "platform": "ubuntu64_hw", 11:44:24 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:44:24 INFO - "branch": "mozilla-beta", 11:44:24 INFO - "repo_path": "releases/mozilla-beta", 11:44:24 INFO - "revision": "eacd3797afb7c4cea080a62274c3eb076fabe196", 11:44:24 INFO - "stage_platform": "linux64-pgo", 11:44:24 INFO - "builduid": "3a21e602a97a4decaab302f291f79a16", 11:44:24 INFO - "slavebuilddir": "test" 11:44:24 INFO - } 11:44:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 11:44:24 INFO - Running post-action listener: _resource_record_post_action 11:44:24 INFO - ##### 11:44:24 INFO - ##### Running download-and-extract step. 11:44:24 INFO - ##### 11:44:24 INFO - Running pre-action listener: _resource_record_pre_action 11:44:24 INFO - Running main action method: download_and_extract 11:44:24 INFO - mkdir: /builds/slave/test/build/tests 11:44:24 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')]} 11:44:24 INFO - https://queue.taskcluster.net/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:44:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:44:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:44:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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 11:44:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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 11:44:26 INFO - Downloaded 1327 bytes. 11:44:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:44:26 INFO - Using the following test package requirements: 11:44:26 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 11:44:26 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:44:26 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:44:26 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:44:26 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 11:44:26 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:44:26 INFO - u'jsshell-linux-x86_64.zip'], 11:44:26 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:44:26 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:44:26 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 11:44:26 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:44:26 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 11:44:26 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:44:26 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 11:44:26 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:44:26 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:44:26 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:44:26 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:44:26 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:26 INFO - https://queue.taskcluster.net/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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 11:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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 11:44:27 INFO - Downloaded 24235837 bytes. 11:44:27 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'] 11:44:27 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 11:44:28 INFO - Return code: 0 11:44:28 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 11:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:28 INFO - https://queue.taskcluster.net/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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 11:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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 11:44:30 INFO - Downloaded 24235837 bytes. 11:44:30 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'] 11:44:30 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 11:44:31 INFO - Return code: 0 11:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:31 INFO - https://queue.taskcluster.net/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:44:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:44:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:44:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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 11:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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 11:44:32 INFO - Downloaded 10840145 bytes. 11:44:32 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'] 11:44:32 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 11:44:32 INFO - Return code: 0 11:44:32 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')]} 11:44:32 INFO - https://queue.taskcluster.net/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:44:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:44:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:44:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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 11:44:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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 11:44:34 INFO - Downloaded 56009156 bytes. 11:44:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:44:34 INFO - mkdir: /builds/slave/test/properties 11:44:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:44:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:44:34 INFO - Contents: 11:44:34 INFO - build_url:https://queue.taskcluster.net/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:44:34 INFO - Running post-action listener: _resource_record_post_action 11:44:34 INFO - Running post-action listener: set_extra_try_arguments 11:44:34 INFO - ##### 11:44:34 INFO - ##### Running populate-webroot step. 11:44:34 INFO - ##### 11:44:34 INFO - Running pre-action listener: _resource_record_pre_action 11:44:34 INFO - Running main action method: populate_webroot 11:44:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:44:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:44:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:44:34 INFO - '--tppagecycles', 11:44:34 INFO - '7'], 11:44:34 INFO - 'tests': ['tsvgm']}}, 11:44:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:44:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:44:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:44:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:44:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:44:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:44:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:34 INFO - 'talos_options': ['--disable-e10s'], 11:44:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:34 INFO - 'talos_options': ['--disable-e10s'], 11:44:34 INFO - 'tests': ['damp', 'tps']}, 11:44:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:34 INFO - 'tests': ['damp', 'tps']}, 11:44:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:44:34 INFO - 'tests': ['dromaeo_dom']}, 11:44:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:44:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:44:34 INFO - 'tests': ['a11yr', 11:44:34 INFO - 'ts_paint', 11:44:34 INFO - 'tpaint', 11:44:34 INFO - 'sessionrestore', 11:44:34 INFO - 'sessionrestore_no_auto_restore', 11:44:34 INFO - 'tabpaint']}, 11:44:34 INFO - 'other-e10s': {'tests': ['a11yr', 11:44:34 INFO - 'ts_paint', 11:44:34 INFO - 'tpaint', 11:44:34 INFO - 'sessionrestore', 11:44:34 INFO - 'sessionrestore_no_auto_restore', 11:44:34 INFO - 'tabpaint']}, 11:44:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:44:34 INFO - 'ts_paint', 11:44:34 INFO - 'tpaint', 11:44:34 INFO - 'sessionrestore', 11:44:34 INFO - 'sessionrestore_no_auto_restore', 11:44:34 INFO - 'tabpaint']}, 11:44:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:44:34 INFO - 'ts_paint', 11:44:34 INFO - 'tpaint', 11:44:34 INFO - 'sessionrestore', 11:44:34 INFO - 'sessionrestore_no_auto_restore', 11:44:34 INFO - 'tabpaint']}, 11:44:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:44:34 INFO - 'tests': ['a11yr', 11:44:34 INFO - 'ts_paint', 11:44:34 INFO - 'tpaint', 11:44:34 INFO - 'sessionrestore', 11:44:34 INFO - 'sessionrestore_no_auto_restore', 11:44:34 INFO - 'tabpaint']}, 11:44:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:44:34 INFO - 'tests': ['a11yr', 11:44:34 INFO - 'ts_paint', 11:44:34 INFO - 'tpaint', 11:44:34 INFO - 'sessionrestore', 11:44:34 INFO - 'sessionrestore_no_auto_restore', 11:44:34 INFO - 'tabpaint']}, 11:44:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:44:34 INFO - 'tests': ['tsvgx', 11:44:34 INFO - 'tsvgr_opacity', 11:44:34 INFO - 'tart', 11:44:34 INFO - 'tscrollx', 11:44:34 INFO - 'cart']}, 11:44:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:44:34 INFO - 'tsvgr_opacity', 11:44:34 INFO - 'tart', 11:44:34 INFO - 'tscrollx', 11:44:34 INFO - 'cart']}, 11:44:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:34 INFO - 'talos_options': ['--disable-e10s'], 11:44:34 INFO - 'tests': ['tp5o']}, 11:44:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:34 INFO - 'tests': ['tp5o']}, 11:44:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:34 INFO - 'talos_options': ['--disable-e10s', 11:44:34 INFO - '--xperf_path', 11:44:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:34 INFO - 'tests': ['tp5n']}, 11:44:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:34 INFO - 'talos_options': ['--xperf_path', 11:44:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:34 INFO - 'tests': ['tp5n']}}, 11:44:34 INFO - 'talos.zip': {'path': '', 11:44:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:44:34 INFO - Running post-action listener: _resource_record_post_action 11:44:34 INFO - ##### 11:44:34 INFO - ##### Running create-virtualenv step. 11:44:34 INFO - ##### 11:44:34 INFO - Running pre-action listener: _resource_record_pre_action 11:44:34 INFO - Running main action method: create_virtualenv 11:44:34 INFO - Creating virtualenv /builds/slave/test/build/venv 11:44:34 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 11:44:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:44:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:44:35 INFO - Using real prefix '/usr' 11:44:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:44:35 INFO - Installing distribute.............................................................................................................................................................................................done. 11:44:37 INFO - Installing pip.................done. 11:44:37 INFO - Return code: 0 11:44:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:37 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 0x7f0b8cc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fee410>, '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 0x1fef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fef7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', '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 11:44:37 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 11:44:37 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 11:44:37 INFO - Using env: {'DISPLAY': ':0', 11:44:37 INFO - 'HOME': '/home/cltbld', 11:44:37 INFO - 'LANG': 'en_US.UTF-8', 11:44:37 INFO - 'LANGUAGE': 'en_US:en', 11:44:37 INFO - 'LOGNAME': 'cltbld', 11:44:37 INFO - 'MAIL': '/var/mail/cltbld', 11:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:37 INFO - 'MOZ_NO_REMOTE': '1', 11:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:37 INFO - 'NO_EM_RESTART': '1', 11:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:37 INFO - 'PWD': '/builds/slave/test', 11:44:37 INFO - 'SHELL': '/bin/bash', 11:44:37 INFO - 'SHLVL': '1', 11:44:37 INFO - 'TERM': 'linux', 11:44:37 INFO - 'TMOUT': '86400', 11:44:37 INFO - 'USER': 'cltbld', 11:44:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', 11:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:37 INFO - '_': '/tools/buildbot/bin/python'} 11:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:37 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 11:44:37 INFO - Cleaning up... 11:44:37 INFO - Return code: 0 11:44:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:37 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 0x7f0b8cc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fee410>, '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 0x1fef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fef7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', '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 11:44:37 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 11:44:37 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 11:44:37 INFO - Using env: {'DISPLAY': ':0', 11:44:37 INFO - 'HOME': '/home/cltbld', 11:44:37 INFO - 'LANG': 'en_US.UTF-8', 11:44:37 INFO - 'LANGUAGE': 'en_US:en', 11:44:37 INFO - 'LOGNAME': 'cltbld', 11:44:37 INFO - 'MAIL': '/var/mail/cltbld', 11:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:37 INFO - 'MOZ_NO_REMOTE': '1', 11:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:37 INFO - 'NO_EM_RESTART': '1', 11:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:37 INFO - 'PWD': '/builds/slave/test', 11:44:37 INFO - 'SHELL': '/bin/bash', 11:44:37 INFO - 'SHLVL': '1', 11:44:37 INFO - 'TERM': 'linux', 11:44:37 INFO - 'TMOUT': '86400', 11:44:37 INFO - 'USER': 'cltbld', 11:44:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', 11:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:37 INFO - '_': '/tools/buildbot/bin/python'} 11:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:37 INFO - Downloading/unpacking psutil>=0.7.1 11:44:37 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 11:44:37 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 11:44:37 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 11:44:37 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 11:44:37 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 11:44:37 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 11:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:44:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:39 INFO - Installing collected packages: psutil 11:44:39 INFO - Running setup.py install for psutil 11:44:40 INFO - building 'psutil._psutil_linux' extension 11:44:40 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 11:44:40 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 11:44:40 INFO - building 'psutil._psutil_posix' extension 11:44:40 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 11:44:40 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 11:44:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:40 INFO - Successfully installed psutil 11:44:40 INFO - Cleaning up... 11:44:40 INFO - Return code: 0 11:44:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:40 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 0x7f0b8cc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fee410>, '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 0x1fef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fef7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', '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 11:44:40 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 11:44:40 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 11:44:40 INFO - Using env: {'DISPLAY': ':0', 11:44:40 INFO - 'HOME': '/home/cltbld', 11:44:40 INFO - 'LANG': 'en_US.UTF-8', 11:44:40 INFO - 'LANGUAGE': 'en_US:en', 11:44:40 INFO - 'LOGNAME': 'cltbld', 11:44:40 INFO - 'MAIL': '/var/mail/cltbld', 11:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:40 INFO - 'MOZ_NO_REMOTE': '1', 11:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:40 INFO - 'NO_EM_RESTART': '1', 11:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:40 INFO - 'PWD': '/builds/slave/test', 11:44:40 INFO - 'SHELL': '/bin/bash', 11:44:40 INFO - 'SHLVL': '1', 11:44:40 INFO - 'TERM': 'linux', 11:44:40 INFO - 'TMOUT': '86400', 11:44:40 INFO - 'USER': 'cltbld', 11:44:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', 11:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:40 INFO - '_': '/tools/buildbot/bin/python'} 11:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:44:40 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 11:44:40 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 11:44:40 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 11:44:40 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 11:44:40 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 11:44:40 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 11:44:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:44:42 INFO - Installing collected packages: mozsystemmonitor 11:44:42 INFO - Running setup.py install for mozsystemmonitor 11:44:42 INFO - Successfully installed mozsystemmonitor 11:44:42 INFO - Cleaning up... 11:44:42 INFO - Return code: 0 11:44:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0b8cc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fee410>, '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 0x1fef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fef7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', '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 11:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:44:42 INFO - Using env: {'DISPLAY': ':0', 11:44:42 INFO - 'HOME': '/home/cltbld', 11:44:42 INFO - 'LANG': 'en_US.UTF-8', 11:44:42 INFO - 'LANGUAGE': 'en_US:en', 11:44:42 INFO - 'LOGNAME': 'cltbld', 11:44:42 INFO - 'MAIL': '/var/mail/cltbld', 11:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:42 INFO - 'MOZ_NO_REMOTE': '1', 11:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:42 INFO - 'NO_EM_RESTART': '1', 11:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:42 INFO - 'PWD': '/builds/slave/test', 11:44:42 INFO - 'SHELL': '/bin/bash', 11:44:42 INFO - 'SHLVL': '1', 11:44:42 INFO - 'TERM': 'linux', 11:44:42 INFO - 'TMOUT': '86400', 11:44:42 INFO - 'USER': 'cltbld', 11:44:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', 11:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:42 INFO - '_': '/tools/buildbot/bin/python'} 11:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:44:42 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 11:44:42 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 11:44:42 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 11:44:42 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 11:44:42 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 11:44:42 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 11:44:44 INFO - Downloading blobuploader-1.2.4.tar.gz 11:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:44:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:44:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:44:45 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 11:44:45 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 11:44:45 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 11:44:45 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 11:44:45 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 11:44:45 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 11:44:45 INFO - Downloading docopt-0.6.1.tar.gz 11:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:44:45 INFO - Installing collected packages: blobuploader, requests, docopt 11:44:45 INFO - Running setup.py install for blobuploader 11:44:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:44:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:44:45 INFO - Running setup.py install for requests 11:44:46 INFO - Running setup.py install for docopt 11:44:46 INFO - Successfully installed blobuploader requests docopt 11:44:46 INFO - Cleaning up... 11:44:46 INFO - Return code: 0 11:44:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:46 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 0x7f0b8cc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fee410>, '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 0x1fef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fef7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', '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 11:44:46 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 11:44:46 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 11:44:46 INFO - Using env: {'DISPLAY': ':0', 11:44:46 INFO - 'HOME': '/home/cltbld', 11:44:46 INFO - 'LANG': 'en_US.UTF-8', 11:44:46 INFO - 'LANGUAGE': 'en_US:en', 11:44:46 INFO - 'LOGNAME': 'cltbld', 11:44:46 INFO - 'MAIL': '/var/mail/cltbld', 11:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:46 INFO - 'MOZ_NO_REMOTE': '1', 11:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:46 INFO - 'NO_EM_RESTART': '1', 11:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:46 INFO - 'PWD': '/builds/slave/test', 11:44:46 INFO - 'SHELL': '/bin/bash', 11:44:46 INFO - 'SHLVL': '1', 11:44:46 INFO - 'TERM': 'linux', 11:44:46 INFO - 'TMOUT': '86400', 11:44:46 INFO - 'USER': 'cltbld', 11:44:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', 11:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:46 INFO - '_': '/tools/buildbot/bin/python'} 11:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:46 INFO - Running setup.py (path:/tmp/pip-cZF3IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:46 INFO - Running setup.py (path:/tmp/pip-mgUBK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:46 INFO - Running setup.py (path:/tmp/pip-MSyL68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:46 INFO - Running setup.py (path:/tmp/pip-xinKLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:46 INFO - Running setup.py (path:/tmp/pip-VAeNec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:46 INFO - Running setup.py (path:/tmp/pip-ahOTZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:46 INFO - Running setup.py (path:/tmp/pip-270Hwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:46 INFO - Running setup.py (path:/tmp/pip-Cb7Daz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:47 INFO - Running setup.py (path:/tmp/pip-Nj_fr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:47 INFO - Running setup.py (path:/tmp/pip-dhF13W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:47 INFO - Running setup.py (path:/tmp/pip-pYHP_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:47 INFO - Running setup.py (path:/tmp/pip-GXim6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:47 INFO - Running setup.py (path:/tmp/pip-sGC2uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:47 INFO - Running setup.py (path:/tmp/pip-gJMDxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:47 INFO - Running setup.py (path:/tmp/pip-6R3i7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:47 INFO - Running setup.py (path:/tmp/pip-zG9HKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:47 INFO - Running setup.py (path:/tmp/pip-jnox6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:44:47 INFO - Running setup.py install for manifestparser 11:44:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:44:47 INFO - Running setup.py install for mozcrash 11:44:47 INFO - Running setup.py install for mozdebug 11:44:48 INFO - Running setup.py install for mozdevice 11:44:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:44:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:44:48 INFO - Running setup.py install for mozfile 11:44:48 INFO - Running setup.py install for mozhttpd 11:44:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:44:48 INFO - Running setup.py install for mozinfo 11:44:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:44:48 INFO - Running setup.py install for mozInstall 11:44:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:44:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:44:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:44:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:44:48 INFO - Running setup.py install for mozleak 11:44:48 INFO - Running setup.py install for mozlog 11:44:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:44:48 INFO - Running setup.py install for moznetwork 11:44:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:44:48 INFO - Running setup.py install for mozprocess 11:44:48 INFO - Running setup.py install for mozprofile 11:44:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:44:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:44:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:44:49 INFO - Running setup.py install for mozrunner 11:44:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:44:49 INFO - Running setup.py install for mozscreenshot 11:44:49 INFO - Running setup.py install for moztest 11:44:49 INFO - Running setup.py install for mozversion 11:44:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:44:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:44:49 INFO - Cleaning up... 11:44:49 INFO - Return code: 0 11:44:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:49 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 0x7f0b8cc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fee410>, '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 0x1fef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fef7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', '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 11:44:49 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 11:44:49 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 11:44:49 INFO - Using env: {'DISPLAY': ':0', 11:44:49 INFO - 'HOME': '/home/cltbld', 11:44:49 INFO - 'LANG': 'en_US.UTF-8', 11:44:49 INFO - 'LANGUAGE': 'en_US:en', 11:44:49 INFO - 'LOGNAME': 'cltbld', 11:44:49 INFO - 'MAIL': '/var/mail/cltbld', 11:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:49 INFO - 'MOZ_NO_REMOTE': '1', 11:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:49 INFO - 'NO_EM_RESTART': '1', 11:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:49 INFO - 'PWD': '/builds/slave/test', 11:44:49 INFO - 'SHELL': '/bin/bash', 11:44:49 INFO - 'SHLVL': '1', 11:44:49 INFO - 'TERM': 'linux', 11:44:49 INFO - 'TMOUT': '86400', 11:44:49 INFO - 'USER': 'cltbld', 11:44:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', 11:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:49 INFO - '_': '/tools/buildbot/bin/python'} 11:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:49 INFO - Running setup.py (path:/tmp/pip-7vvp16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:49 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)) 11:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:49 INFO - Running setup.py (path:/tmp/pip-nUpy5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:49 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)) 11:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:49 INFO - Running setup.py (path:/tmp/pip-Eoycnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:49 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)) 11:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:49 INFO - Running setup.py (path:/tmp/pip-RAsHze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:50 INFO - Running setup.py (path:/tmp/pip-Qyf0sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:50 INFO - Running setup.py (path:/tmp/pip-OesIJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:50 INFO - Running setup.py (path:/tmp/pip-N7GHdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:50 INFO - Running setup.py (path:/tmp/pip-6CPPTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:50 INFO - Running setup.py (path:/tmp/pip-AETIxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:50 INFO - Running setup.py (path:/tmp/pip-EPwZsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:50 INFO - Running setup.py (path:/tmp/pip-BCfEM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:50 INFO - Running setup.py (path:/tmp/pip-BdxPj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:50 INFO - Running setup.py (path:/tmp/pip-cqwK24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:50 INFO - Running setup.py (path:/tmp/pip-b2tkz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:50 INFO - Running setup.py (path:/tmp/pip-6gytVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:50 INFO - Running setup.py (path:/tmp/pip-clUyxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:50 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)) 11:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:50 INFO - Running setup.py (path:/tmp/pip-9EC3_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:50 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)) 11:44:50 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)) 11:44:50 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)) 11:44:50 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)) 11:44:50 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)) 11:44:50 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)) 11:44:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44:52 INFO - Downloading blessings-1.6.tar.gz 11:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:44:52 INFO - Installing collected packages: blessings 11:44:52 INFO - Running setup.py install for blessings 11:44:53 INFO - Successfully installed blessings 11:44:53 INFO - Cleaning up... 11:44:53 INFO - Return code: 0 11:44:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:44:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:53 INFO - Reading from file tmpfile_stdout 11:44:53 INFO - Current package versions: 11:44:53 INFO - argparse == 1.2.1 11:44:53 INFO - blessings == 1.6 11:44:53 INFO - blobuploader == 1.2.4 11:44:53 INFO - docopt == 0.6.1 11:44:53 INFO - manifestparser == 1.1 11:44:53 INFO - mozInstall == 1.12 11:44:53 INFO - mozcrash == 0.17 11:44:53 INFO - mozdebug == 0.1 11:44:53 INFO - mozdevice == 0.48 11:44:53 INFO - mozfile == 1.2 11:44:53 INFO - mozhttpd == 0.7 11:44:53 INFO - mozinfo == 0.9 11:44:53 INFO - mozleak == 0.1 11:44:53 INFO - mozlog == 3.1 11:44:53 INFO - moznetwork == 0.27 11:44:53 INFO - mozprocess == 0.22 11:44:53 INFO - mozprofile == 0.28 11:44:53 INFO - mozrunner == 6.11 11:44:53 INFO - mozscreenshot == 0.1 11:44:53 INFO - mozsystemmonitor == 0.0 11:44:53 INFO - moztest == 0.7 11:44:53 INFO - mozversion == 1.4 11:44:53 INFO - psutil == 3.1.1 11:44:53 INFO - requests == 1.2.3 11:44:53 INFO - wsgiref == 0.1.2 11:44:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:53 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 0x7f0b8cc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fee410>, '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 0x1fef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fef7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', '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 11:44:53 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 11:44:53 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 11:44:53 INFO - Using env: {'DISPLAY': ':0', 11:44:53 INFO - 'HOME': '/home/cltbld', 11:44:53 INFO - 'LANG': 'en_US.UTF-8', 11:44:53 INFO - 'LANGUAGE': 'en_US:en', 11:44:53 INFO - 'LOGNAME': 'cltbld', 11:44:53 INFO - 'MAIL': '/var/mail/cltbld', 11:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:53 INFO - 'MOZ_NO_REMOTE': '1', 11:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:53 INFO - 'NO_EM_RESTART': '1', 11:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:53 INFO - 'PWD': '/builds/slave/test', 11:44:53 INFO - 'SHELL': '/bin/bash', 11:44:53 INFO - 'SHLVL': '1', 11:44:53 INFO - 'TERM': 'linux', 11:44:53 INFO - 'TMOUT': '86400', 11:44:53 INFO - 'USER': 'cltbld', 11:44:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', 11:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:53 INFO - '_': '/tools/buildbot/bin/python'} 11:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:53 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)) 11:44:53 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)) 11:44:53 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)) 11:44:53 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)) 11:44:53 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)) 11:44:53 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)) 11:44:53 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)) 11:44:53 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)) 11:44:53 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)) 11:44:53 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)) 11:44:53 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)) 11:44:53 INFO - Cleaning up... 11:44:53 INFO - Return code: 0 11:44:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:53 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 0x7f0b8cc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fee410>, '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 0x1fef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fef7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', '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 11:44:53 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 11:44:53 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 11:44:53 INFO - Using env: {'DISPLAY': ':0', 11:44:53 INFO - 'HOME': '/home/cltbld', 11:44:53 INFO - 'LANG': 'en_US.UTF-8', 11:44:53 INFO - 'LANGUAGE': 'en_US:en', 11:44:53 INFO - 'LOGNAME': 'cltbld', 11:44:53 INFO - 'MAIL': '/var/mail/cltbld', 11:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:53 INFO - 'MOZ_NO_REMOTE': '1', 11:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:53 INFO - 'NO_EM_RESTART': '1', 11:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:53 INFO - 'PWD': '/builds/slave/test', 11:44:53 INFO - 'SHELL': '/bin/bash', 11:44:53 INFO - 'SHLVL': '1', 11:44:53 INFO - 'TERM': 'linux', 11:44:53 INFO - 'TMOUT': '86400', 11:44:53 INFO - 'USER': 'cltbld', 11:44:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', 11:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:53 INFO - '_': '/tools/buildbot/bin/python'} 11:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:53 INFO - Downloading/unpacking jsonschema 11:44:53 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 11:44:53 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 11:44:53 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 11:44:53 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 11:44:53 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 11:44:53 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 11:44:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:44:55 INFO - Downloading/unpacking functools32 (from jsonschema) 11:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:44:55 INFO - warning: no files found matching '*.txt' 11:44:55 INFO - no previously-included directories found matching 'build' 11:44:55 INFO - no previously-included directories found matching 'dist' 11:44:55 INFO - no previously-included directories found matching '.git*' 11:44:56 INFO - Installing collected packages: jsonschema, functools32 11:44:56 INFO - Running setup.py install for functools32 11:44:56 INFO - warning: no files found matching '*.txt' 11:44:56 INFO - no previously-included directories found matching 'build' 11:44:56 INFO - no previously-included directories found matching 'dist' 11:44:56 INFO - no previously-included directories found matching '.git*' 11:44:56 INFO - Successfully installed jsonschema functools32 11:44:56 INFO - Cleaning up... 11:44:56 INFO - Return code: 0 11:44:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:56 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 0x7f0b8cc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fee410>, '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 0x1fef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fef7a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', '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 11:44:56 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 11:44:56 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 11:44:56 INFO - Using env: {'DISPLAY': ':0', 11:44:56 INFO - 'HOME': '/home/cltbld', 11:44:56 INFO - 'LANG': 'en_US.UTF-8', 11:44:56 INFO - 'LANGUAGE': 'en_US:en', 11:44:56 INFO - 'LOGNAME': 'cltbld', 11:44:56 INFO - 'MAIL': '/var/mail/cltbld', 11:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:56 INFO - 'MOZ_NO_REMOTE': '1', 11:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:56 INFO - 'NO_EM_RESTART': '1', 11:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:56 INFO - 'PWD': '/builds/slave/test', 11:44:56 INFO - 'SHELL': '/bin/bash', 11:44:56 INFO - 'SHLVL': '1', 11:44:56 INFO - 'TERM': 'linux', 11:44:56 INFO - 'TMOUT': '86400', 11:44:56 INFO - 'USER': 'cltbld', 11:44:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', 11:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:56 INFO - '_': '/tools/buildbot/bin/python'} 11:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:56 INFO - Downloading/unpacking flake8 11:44:56 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 11:44:56 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 11:44:56 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 11:44:56 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 11:44:56 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 11:44:56 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 11:44:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:44:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:44:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:44:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:44:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:44:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:44:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:44:59 INFO - no previously-included directories found matching 'docs/_build' 11:44:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:44:59 INFO - Running setup.py install for pep8 11:44:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:44:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:44:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:44:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:44:59 INFO - no previously-included directories found matching 'docs/_build' 11:44:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:44:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:44:59 INFO - Cleaning up... 11:44:59 INFO - Return code: 0 11:44:59 INFO - Running post-action listener: _resource_record_post_action 11:44:59 INFO - Running post-action listener: _start_resource_monitoring 11:44:59 INFO - Starting resource monitoring. 11:44:59 INFO - ##### 11:44:59 INFO - ##### Running install step. 11:44:59 INFO - ##### 11:44:59 INFO - Running pre-action listener: _resource_record_pre_action 11:44:59 INFO - Running main action method: install 11:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:59 INFO - Reading from file tmpfile_stdout 11:44:59 INFO - Detecting whether we're running mozinstall >=1.0... 11:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:44:59 INFO - Reading from file tmpfile_stdout 11:44:59 INFO - Output received: 11:44:59 INFO - Usage: mozinstall [options] installer 11:44:59 INFO - Options: 11:44:59 INFO - -h, --help show this help message and exit 11:44:59 INFO - -d DEST, --destination=DEST 11:44:59 INFO - Directory to install application into. [default: 11:44:59 INFO - "/builds/slave/test"] 11:44:59 INFO - --app=APP Application being installed. [default: firefox] 11:44:59 INFO - mkdir: /builds/slave/test/build/application 11:44:59 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'] 11:44:59 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 11:45:12 INFO - Reading from file tmpfile_stdout 11:45:12 INFO - Output received: 11:45:12 INFO - /builds/slave/test/build/application/firefox/firefox 11:45:12 INFO - Running post-action listener: _resource_record_post_action 11:45:12 INFO - ##### 11:45:12 INFO - ##### Running run-tests step. 11:45:12 INFO - ##### 11:45:12 INFO - Running pre-action listener: _resource_record_pre_action 11:45:12 INFO - Running main action method: run_tests 11:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:45:12 INFO - Python 2.7.3 11:45:12 INFO - Return code: 0 11:45:12 INFO - grabbing minidump binary from tooltool 11:45:12 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')]} 11:45:12 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 0x1fee410>, '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 0x1fef310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fef7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:45:12 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 11:45:12 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 11:45:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:45:13 INFO - Return code: 0 11:45:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:45:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:45:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:45:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:45:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:45:13 INFO - Return code: 0 11:45:13 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/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 11:45:13 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/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 11:45:13 INFO - Using env: {'DISPLAY': ':0', 11:45:13 INFO - 'HOME': '/home/cltbld', 11:45:13 INFO - 'LANG': 'en_US.UTF-8', 11:45:13 INFO - 'LANGUAGE': 'en_US:en', 11:45:13 INFO - 'LOGNAME': 'cltbld', 11:45:13 INFO - 'MAIL': '/var/mail/cltbld', 11:45:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:13 INFO - 'MOZ_NO_REMOTE': '1', 11:45:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:13 INFO - 'NO_EM_RESTART': '1', 11:45:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:13 INFO - 'PWD': '/builds/slave/test', 11:45:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:13 INFO - 'SHELL': '/bin/bash', 11:45:13 INFO - 'SHLVL': '1', 11:45:13 INFO - 'TERM': 'linux', 11:45:13 INFO - 'TMOUT': '86400', 11:45:13 INFO - 'USER': 'cltbld', 11:45:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603', 11:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:13 INFO - '_': '/tools/buildbot/bin/python'} 11:45:13 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/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 11:45:14 INFO - mozversion application_buildid: 20160627090417 11:45:14 INFO - mozversion application_changeset: eacd3797afb7c4cea080a62274c3eb076fabe196 11:45:14 INFO - mozversion application_display_name: Firefox 11:45:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:45:14 INFO - mozversion application_name: Firefox 11:45:14 INFO - mozversion application_remotingname: firefox 11:45:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:45:14 INFO - mozversion application_vendor: Mozilla 11:45:14 INFO - mozversion application_version: 48.0 11:45:14 INFO - mozversion platform_buildid: 20160627090417 11:45:14 INFO - mozversion platform_changeset: eacd3797afb7c4cea080a62274c3eb076fabe196 11:45:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:45:14 INFO - mozversion platform_version: 48.0 11:45:14 INFO - using testdate: 1467053114 11:45:14 INFO - actual date: 1467053114 11:45:14 INFO - starting webserver on 'localhost:40880' 11:45:14 INFO - SUITE-START | Running 2 tests 11:45:14 INFO - TEST-START | dromaeo_css 11:45:14 INFO - operating with platform_type : linux_ 11:45:14 INFO - Initialising browser for dromaeo_css test... 11:45:14 INFO - TEST-INFO | started process 11424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNmmhkp/profile http://localhost:40880/getInfo.html) 11:45:18 INFO - PROCESS | 11424 | __metrics Screen width/height:1600/1200 11:45:18 INFO - PROCESS | 11424 | colorDepth:24 11:45:18 INFO - PROCESS | 11424 | Browser inner width/height: 1024/697 11:45:18 INFO - PROCESS | 11424 | __metrics 11:45:19 ERROR - PROCESS | 11424 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:45:19 INFO - TEST-INFO | 11424: exit 0 11:45:19 INFO - Browser initialized. 11:45:19 INFO - Running cycle 1/1 for dromaeo_css test... 11:45:19 INFO - TEST-INFO | started process 11518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNmmhkp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:31 INFO - PROCESS | 11518 | RSS: Main: 139694080 11:45:31 INFO - PROCESS | 11518 | 11:46:23 INFO - PROCESS | 11518 | 1467053183091 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] 11:48:30 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:40880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40880/tests/dromaeo/cssquery-ext.html) 11:48:31 INFO - PROCESS | 11518 | RSS: Main: 249180160 11:48:31 INFO - PROCESS | 11518 | 11:51:33 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:40880/tests/dromaeo/cssquery-ext.html (next: http://localhost:40880/tests/dromaeo/cssquery-jquery.html) 11:51:34 INFO - PROCESS | 11518 | RSS: Main: 222728192 11:51:34 INFO - PROCESS | 11518 | 11:54:35 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:40880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40880/tests/dromaeo/cssquery-mootools.html) 11:54:36 INFO - PROCESS | 11518 | RSS: Main: 217051136 11:54:36 INFO - PROCESS | 11518 | 11:57:38 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:40880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40880/tests/dromaeo/cssquery-prototype.html) 11:57:38 INFO - PROCESS | 11518 | RSS: Main: 222490624 11:57:38 INFO - PROCESS | 11518 | 12:00:41 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:40880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40880/tests/dromaeo/cssquery-yui.html) 12:00:41 INFO - PROCESS | 11518 | RSS: Main: 183984128 12:00:41 INFO - PROCESS | 11518 | 12:03:44 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:40880/tests/dromaeo/cssquery-yui.html (next: http://localhost:40880/tests/dromaeo/cssquery-dojo.html) 12:03:44 INFO - PROCESS | 11518 | RSS: Main: 249356288 12:03:44 INFO - PROCESS | 11518 | 12:03:44 INFO - PROCESS | 11518 | __start_tp_report 12:03:44 INFO - PROCESS | 11518 | _x_x_mozilla_page_load 12:03:44 INFO - PROCESS | 11518 | _x_x_mozilla_page_load_details 12:03:44 INFO - PROCESS | 11518 | |i|pagename|runs| 12:03:44 INFO - PROCESS | 11518 | |0;dojo.html;3267.395531826612;3315.8839440619577;3329.750268729846;3356.110630682868;3386.8306584670777;5544.306961629796;5553.8333849984465;5555.138953462209;5563.443655634434;5567.109262517998;5560.082586373243;5580.135079062752;5582.051051321275;5582.888342233153;5616.157576363547;4995.275685025669;5000.549950504454;5081.364829396325;5115.667481613702;5161.303224064741;5005.849824505271;5067.619928505358;5073.543381095719;5105.157648987913;5111.488851114896;5182.378114626231;5182.714950677711;5219.686818790866;5226.477352264781;5229.450907654698;5201.557867581241;5207.984443033591;5216.191490319006;5220.895582088375;5253.9737301313635;4983.177775667011;5013.398392192924;5076.492350764931;5101.489851014906;5113.821016264413;5424.620276580641;5448.863778405532;5451.972740136274;5466.098093814516;5489.258950041733;5868.618539794899;5900;5910.497607703351;5920.851978700523;5921.407859214087;5915;5976.820695379146;6064.36324185963;6123.969380153116;6135.938640613582;5586.664800112007;5596.684779076913;5598.272224610815;5598.720063996825;5611.2144299798065;6028.5478589106;6066.726997285133;6070.180525629072;6084.178635884187;6087.726052327655;5793.2179155814265;5955.642661440241;6025.3372129065765;6055;6058.182145410401;6089.48239399656;6101.96949015261;6106.969465152734;6112.99135642614;6115.0215965446205;5906.055031195074;6000.669963152069;6067.635941843503;6076.422739839708;6080.391960803884;5949.405059494103;6019.458248757633;6036.849078773066;6062.969685151546;6071.9696401518595;4554.908901821945;4556.088782243564;4557.840475583339;4572.725636461823;4584.129015487047;4012.1975604878558;4066.1257829566784;4069.2878746219294;4074.7758873261664;4075.5313138989395;5638.802641907513;5656.151577263443;5671.489565939085;5679.2333035040565;5694.5159661428415;5960.3443621202505;5973.492253158443;5979.8206053817585;5982.790602328898;5992.13114098462;5564.165375193753;5649.915251271234;5680.630759000652;5761.3950535194035;5876.177335173079;5051.318072060299;5053.747312634354;5062.797488100508;5062.873428164326;5100.821471248489;6064.4845188158615;6069.575129740964;6077.696115194222;6106.938930610726;6125.754969801247;5916.822495325061;6040.305364882919;6046.2139921809885;6109.435031337353;6116.082587611894;6143.232095988002;6204.81385558434;6208.037754148114;6208.844778880564;6213.751449942132;5883.058710606282;5883.911741323969;5895.557833162444;5897.3807750185615;5904.881902362014;5766.509846662912;6097.817065488042;6127.708789264132;6139.185504090546;6160.106784516131;5933.050711886078;5949.315828679757;5961.642301461926;5966.463018328372;5969.194158788681;5810.73851676684;5964.194833697396;5982.341942386421;5982.760689572542;6003.309619393651;5804.593678442468;5841.824745257649;5843.211166492469;5877.794277200277;5892.381299963442;5870.354261031198;5908.527317814651;5912.940870591239;5919.467247947706;5942.405759424023;5724.513416359656;5767;5784.1034639630925;5787.797427090031;5832.096025116114 12:03:44 INFO - PROCESS | 11518 | |1;ext.html;665.0224170469409;673.1787219592097;682.3006418421121;731.4989232375822;734.819969107569;35066.649333506655;36081.0979725507;39890.202195956066;40858.38712419309;41013.794931025375;45040.549594504046;45585;45679.31481027779;45737;45741.77129114358;8112.107668156527;8831.205191532745;9009.909900901006;9014.68448604299;9015.864762028576;10816.188785841054;11095.778084438307;11104.55581776728;11105.83341249882;11109.277896936714;10668.30656007361;10721.946390268038;10737.087347575465;10742.248042637018;10751;10602.840957385646;10663.306885052447;10669.946650266776;10672.199585031114;10678;10268.640597579124;10393.79212415755;10416.739581510446;10423.530941107669;10431.687049388454;43757;43914.78042609798;44143.77928110371;44153.77923110364;44258.33612495815;3680.3743363628246;3738.401855703102;3745.3071181831447;3803.2583646189005;3884.9611503885167;30154.09537713872;30359.392812143855;30780;30792.230194245098;30969.535456968162;4426.513083560806;4440.622547083502;4497.257952437843;4576.427946506687;4639.884002899921;214058;215049;215225.9238703812;215228;215739;61813;61967.690161548904;62074.379256207765;62119.44701382411;62146.68926655338;68957.65521172361;70817.64591177113;70853;70888.64555677188;70976;19105.426837194907;19312.03439828003;19339.4198174055;19370.4188874334;19374.90312548428;13337.866621333857;14581.708365832625;14910.925445372704;14927.40290388394;14942.850571494146;19731.309404170785;19833.60332793336;19923.20307187725;19948.102335394942;20015.299464518674;7249.891251631229;7266.418686505067;7320.597367144752;7475.588842613708;7502.512336698097;1069.0859315285475;1110.4003837927428;1160.6797416743564;1166.8133098704166;1202.7414105967084;33549.83225083908;33868.49197262043;33926.66073339284;33996.150096247795;34172.14569635779;1216.197309775544;1226.3868065967017;1258.6658142369117;1282.4613662261872;1291.651254161371;17961.550961225814;18394.7926248851;19237.711434328496;19332;19370.80629193718;484756;484878;488859;489240;490336;63433.68283158647;64149.67925160344;64153.679231604474;64194.03708944369;64211.678941604994;1409.302395314326;1471.9411223550937;1530.5637893200385;1552.1773460066183;1620.0765563628618;30275.697243027287;32201;32871;33092.669073308956;33174.66825331812;51307.48692513027;52103;52108.73945630248;52112.21831672604;52120.478795211566;355757;356627;357616;358154;358330;28905.277368065126;30048.3990320188;30231.848840755654;30325;30359.241018974702;49040.2643960348;49338.75330623468;49415.50584494109;49445.50554494409;50502.979880804356;41442.792786035876;42574.78712606417;42721.57278427176;43268.35097473604;43597.782011089745;40469.1906161881;41510.37734433926;41905.37141942934;42271;42296.57703422927;42509.14981700287;43047;43568.12863742644;43603;43608.34587481254;35570.288594228485;36677.26645467129;36961.61640184119;37110;37345.253094937405;28566.285842854097;28669.426611467235;28679.283017924718;28683.56974645424;28803.423931521673 12:03:44 INFO - PROCESS | 11518 | |2;jquery.html;414.44257473697877;423.27197220780266;423.8389412023433;424.6369354202159;435.25354017859377;17987.37044203453;18332.266709331627;18911.148998295077;19022.61954760904;19747.802521974776;19027.90486047571;19310;19705;20626.48433789156;20643.38069857903;5660.9716951415185;5709.31488221414;5759.769609215627;5762.769489220447;5887.88224235515;5714.771409143629;5726.770929162829;5738.254026976487;5745.511631511326;5761.971190144043;5553.389127196006;5712.371639119693;5727.484526392624;5763.279590051244;5876.794312199074;5778.682172480512;5833.445822646841;5845.795397161121;5847.619904706202;5852.326982397015;5233.738313084331;5244.895102097975;5281.471852814688;5290.973545132289;5291.391489978663;23128.306150815504;23296.417589560227;23753.88123059391;23771.1680091196;23819.88090059556;2366.4675448024227;2447.865367404792;2620.2794231586277;3092.304231547906;3306.2560923792194;10326.896731032668;10500.369977801356;10590.788184236271;11718.707032324175;14654.120752754869;1805.2869116698962;2010.5275260313815;2054.0551346380685;2093.9895300523553;2134.7545032321327;76147.61926190389;76303.61848190779;79595;79667.99999999942;81103.18896811074;11589;11646;11737.06103511717;11805.645830625095;11902.583409580624;16232.675346493004;16427.753583696016;16468.0942548161;16517.834821651628;16587.502374928772;8662.436941598777;8671.826563468696;8673.826523469621;8759.518226497605;8774.078721734253;8259.463134896212;8284.71003514874;8314.958425207957;8430.283425908867;8470.830583388297;5012.924806127911;5053.393592768891;5076.213186956028;5102.923456148161;5134;2090.7177531033117;2098.7901209879196;2138.967915481269;2153.8707677539396;2196.2313190383557;1021.5045702834119;1030.8711411073616;1129.9717257295822;1137.8293256011664;1139.0944199361527;18539;18667.626647466976;18813.638113137964;19353.90323048404;19655;1064.7178497698117;1097.7639807441278;1105.922585419029;1116.8827273136367;1126.0541145437871;10323.793524129474;10920;10978.670639880816;11047.281926674741;11186.720331991603;504703;513699;517944;521821;524800;50020.49979500231;90400.5479972596;90620.54689726509;93745.53127234457;95585.5220723892;1081.6809041332826;1122.7080958950569;1127.785720713062;1140.9087273018138;1158.8145896656663;17182;17200.569985750455;17202.13989300555;17385.47843564695;17480.863743856607;29770.553441697957;39012.80493597514;40721.79639101786;41540;42141;55682;56183.71908140433;56232.718836405555;57296;57381.71309143428;8450.070492245972;8463.407561470638;8477.73607161235;8506.276966457921;8520;9140.908590914272;13503.12229705066;13887.513937012156;14052.513172989356;14265.358058887168;11775;12356.567520136752;12369.567065152676;12438.440270187682;12478.064145189328;11693.707657308636;11962.521499139937;12015.219010764273;12039.879601204226;12144.332061736335;12164.209326393757;12312.50749970027;12380.81428778587;12433;12529.749405012031;8703.564821759013;8916.86624700643;9154.908450915405;12269.386530673251;13534.796978045533;11791.941040294743;11861.169718119649;12042.458089386173;12724.936375318064;12819.935900320439 12:03:44 INFO - PROCESS | 11518 | |3;mootools.html;1440.0351764317907;1531.9463818766344;1600.1199340362798;1785.8035616082236;1873.4660621722812;7844.803879902998;8052.798680033002;8056.959715201423;8058.274755272032;8062.798430039252;7902.841943161134;8063.193680631948;8080.636371363288;8089.0293164820305;8094.433389662726;2379.690640216769;2401.1835975768236;2404.0984630763464;2406.819488538367;2417.2748175547354;2420.3344080377947;2455.26342097371;2457.2628211536558;2459.56957532432;2472.196536125757;2357.127862690807;2384.0344660412475;2407.374082738492;2428.490017096403;2459.8770061496944;2313.248194336847;2381.880905954704;2399.0523743121457;2399.652050452692;2399.892004859768;2382.725986511556;2413.3966508372905;2435.866027368494;2438.1953955194745;2444.828861979662;7169;7797.064352277763;8250.917490825135;8297.875531867026;8297.95851020747;5090.9236361454605;5165;5197.922031169535;5204.921926171072;5205.843824685266;3499.61504234534;3531.1525233943926;3557.3063252665743;3623.3477973964677;3659.176685245825;1245.7446223524155;1306.8431788185383;1325.7945018522048;1355.3494322725048;2227.151598159915;10773.299735517245;10850.837237441445;10854;10868.728281792939;10891.01980821722;4314.89212769677;4364.978175109168;4379.97070688388;4416.867493975186;4419.9337009944875;8838.204561589488;8845.24815390699;8847.071057538995;8847.823043539092;8848.46909185451;5128.025675121715;5138.3833939927445;5212.087884620177;5215.374155101412;5217.556507696812;4851.611871050308;4881.219004959261;4885.047415753965;4891.853244402673;4893.828715994994;3520.436730123168;3708.2212735325343;3727.683146932541;3737.177820879402;3739.719521035933;1097.2209731090854;1119.1997721629075;1123.9606613768642;1132.0999805154922;1132.9037031852386;919.8712180294764;989.7624570103123;997.2570435025953;1023.0690072034562;1041.5677493839971;5603.80386686464;5624.578156638268;5657.9434205658235;5730.570207234474;5792.507636850831;1000.4947501511836;1011.8785745710414;1033.1734612310122;1051.0540513537876;1055.1822337688352;3983.8406463741703;4001.4397984282223;4013.8795836124964;4025.5169379674626;4036.4752582164133;9904.257180711475;10371.429571373495;10380.844287335696;10388.636397726043;10421.843672344921;10314.48427578618;10471.16230701542;10472.371657700562;10486.213533984828;10487.842682359771;8043.235892590194;8073.878891816627;8179.854820325159;8182.099969003405;8189.344852411912;5526.309211348582;5597.468240517144;5684.346300175533;5724.771009159587;5800.1589769484035;8955.462672239686;9249.260059195114;9339.066093390607;9339.673111441067;9342.859857102014;9387.436753794795;9446;9579.616815327308;9590.712278631652;9652.227821774382;7405.259474052552;7499.100107986858;7522.473426860067;7523.172451030492;7535.924640753522;8014.639341229776;8061.1938806118915;8062.314703250289;8069.3544516439715;8080.555569443737;7374.6681399336085;7403.888941665987;7417.865114359979;7495.662695178621;7559.508631938907;7399.260073992557;7409.036825212688;7413.2957369049855;7489.8876516851205;7520.097588289222;6767.93232067673;6889.173299204128;6917.169939607279;6999.160100787938;7005.334493223136;4095.7133000690856;5029.346184995927;5068.695878247317;5140.151874940593;5144.279800827962;4994.525520075587;5007.098722230034;5015.247712843103;5035.773390197377;5038.14351560243 12:03:44 INFO - PROCESS | 11518 | |4;prototype.html;335.89923023093064;347.32445393709236;348.30339321357275;362.3278817792994;362.4418395670667;6091.208142941423;6228.875422491547;6305.810825675226;6334.176557047583;6378.872422551552;6202.100695399165;6323.715432805523;6331.55679102463;6337.461315788163;6339.11252424661;4845.733484658343;4869.561739443449;4872.317875497433;4881.34101896243;4885.804567817283;4636.4899861015265;4686.601638860701;4776.880577985544;4871.4397844248015;4884.511548845123;4750.952490475085;4791.664583479158;4796.568308852203;4808.422989241296;4817.325574419584;4781.497942716034;4784.712917224978;4799.496052914464;4799.928001079987;4802.111609352246;4206.116715489751;4210.621044106045;4220.261454245495;4223.97888010561;4229.238737027334;6072.423119803611;6076.270847498328;6081.11823785553;6085.148079268906;6097.268327800648;5384.703841288728;5584.6090773645865;5589.357223919261;5597.888042239132;5612.550995920357;6619.5035372347265;6639.93360066398;6647.036179753909;6650.667466626698;6653.500987425914;4592.908141837178;4600.35595016698;4602.355670206174;4605.125026245037;4609.03210325832;6865.725370985155;6933.514653974224;6938.687759050855;6944.305569443066;6945.7221711132;4687.156311863897;4716.646251531149;4718.598919091847;4722.079194557097;4722.504137065559;4708.364370809897;4771.880702982384;4774.092922344813;4777.092352453023;4783;5487.890242195133;5523.530499907472;5539.279893613804;5562.110062389998;5574.136008918624;6622.304658010839;6655.900161497581;6669.599824010478;6673.065770792093;6685.097511835937;1639.9344026238816;1691.7969843618844;1705.9573510662333;1736.8436840684399;1740.843324100837;1155.9075273978062;1176.0650283025016;1183.7099910521806;1184.8874356936078;1190.9404529773476;6442.291347951722;6457.547971642034;6463.64449955257;6464.515161362822;6466.80364132637;6812.352826481477;6813.727450901908;6814.080099186546;6817.795466136024;6839.350261725128;6441.259255185713;6443.710033048524;6445.967770161119;6452.77415290472;6487.416132547999;3661.7436779425184;3682.576503702055;3690.9815450922574;3692.649198326155;3693.076730817296;6950.366663833995;7118.359347658632;7124.6081465518855;7124.821879453055;7128.394086502602;6970.930290697028;6989.196242432084;7000;7003.614801185881;7004.334588214111;7075.610841403669;7081.468889833283;7096.432285417154;7096.467764917652;7096.787096387116;6820.874555698452;6826.283240259701;6826.692798824164;6834.624095674786;6843.110395648534;6548;6698.799036028927;6728.899066513908;6740.494462915203;6744.460443164437;7044.260352663102;7076.221615622175;7086.185088714864;7091.184513780981;7118.216996130525;4878.9512104878495;4882.6338024649;4888;4895.339129217653;4895.559399654048;6704.463642908653;6752.426043786333;6848.520603557703;6849.589024658537;6851.177858656993;6696.59820410777;6699.598024118569;6736.326367363225;6738.561993470409;6758;6727.966360168168;6734.696938637675;6751.3248675134055;6754.425873800782;6760.053592496956;6629.46964242869;6635.303293154342;6635.303293154342;6637.668116594247;6646.2356828965285;6561.704723287559;6794;6801.863962720817;6830.658467076527;6844.828879278058;6584.7036883341325;6634.0712300278965;6634.635095069624;6645.833854153685;6647.302033286435 12:03:44 INFO - PROCESS | 11518 | |5;yui.html;815.779739470343;817.9386546009051;840.7982084299762;908.0964440381821;914.5427286356821;13760.082905271754;14227.075240109398;14515.419383224686;14600.70798584029;14733.336999835006;13812.447502099929;13873.722525549483;13928.30358482077;14008.439662413492;14024.088434251766;882.7351794461651;898;903.9231665308457;904.4256896870502;905.1446383167876;754.0687251244735;887.5828360670474;897.9865302020474;901.5852707754408;907.1110311894347;934.1779234273863;934.6635211323918;936.3773090894547;938.9014153513886;940.952952352383;790.3203245209115;932.8227636748996;934;934.626149540186;935.6351023100996;685.1846302899534;689.3864460630043;689.5311188391892;690.6063543780048;691.1774987764544;14467.493637722735;14480.131192128401;14574.41702331916;14724.779128313085;14732.70534589313;13506.459741610324;14275.35760890752;14418.711625767426;14433;14653.194074325907;11290.887091129065;11360.602378916697;11626.186166968231;11662.183647144704;11774.587889423829;3821.407681809324;3843.8846834595006;3864.478295430137;3892.5134358205223;3912.3349030664854;52925.941481170164;53587;54096.45903540993;57169;57306.713466432404;11239.263315478207;11405.315681059163;11420.714482138013;11622.825657615143;12252.509899604094;19973.600527989358;20001;20018.89990550038;20070.39788806338;20088.49778755543;8439.451435656663;8450.704225352083;8526.190011948855;8530.573471326408;8702.086280940537;4682.227432473604;4751.073540659608;4877.975610121926;4894.290327902506;4967.875803104879;3604.675579197885;3634.854605815791;3652.543432070991;3658.176910195185;3660.615635358249;668.6055227415848;684.5789839248926;685.5989246290976;694.2779509310361;694.6457306773481;669.9548704021742;698.5250029979561;713.3294702979183;784.486161564165;810.0926961802701;9724.222062235005;10129;10169.9491502542;10182.694519164437;10238.846417303746;711.3242419701304;754.8565772503207;816.3387655998661;816.4733746733442;819.8975128108987;4204.159168166379;4428.623566996777;4527.162474942146;4641.094986477672;4732.71603703772;63886;63982.48096354652;64279.67860160669;64293.678531607045;65107;54804;57865.13202301969;58780.7060964701;58825.70587147037;59049.70475147597;50704.74647626812;51153.23270150951;51213;52030.73984630052;52526.737366312926;8627.654893804429;8681;9056.501892395981;9070.600298192445;9290.16388525036;38194.42708359321;38764;38818;39227.41158882562;40003.79998099991;45617.54382456266;48897;49009.26486102783;49887.75056124696;50171.498285016685;11565.768684626091;11597.82603260935;11631;11693.415329233674;11872.82190767122;12317.75364492723;12453.688657783629;12831.743365132832;12973.286469244282;13360.465581377024;11456.198066135625;11717.238379505305;11862.644120676394;11916.404179790803;12005.039596832406;11932.880671193177;12020.218685785396;12025.759484810429;12035;12651.746965060463;11530.654080377602;11550.422478875855;11557.075433965094;11560.30638161713;11798.705032374259;9662.758431039;9816.067473589997;9946.850797237903;9951.203903687832;10371.325863818827;9660.806783864424;10057.195424365887;10071.446070466194;10072.949635251776;10118.241131914989 12:03:44 INFO - PROCESS | 11518 | __end_tp_report 12:03:44 INFO - PROCESS | 11518 | __start_cc_report 12:03:44 INFO - PROCESS | 11518 | _x_x_mozilla_cycle_collect,832 12:03:44 INFO - PROCESS | 11518 | __end_cc_report 12:03:44 INFO - PROCESS | 11518 | __startTimestamp1467054224341__endTimestamp 12:03:44 INFO - PROCESS | 11518 | 12:03:44 INFO - PROCESS | 11518 | ------- Summary: start ------- 12:03:44 INFO - PROCESS | 11518 | Number of tests: 6 12:03:44 INFO - PROCESS | 11518 | 12:03:44 INFO - PROCESS | 11518 | [#0] dojo.html Cycles:165 Average:5578.17 Median:5832.10 stddev:631.38 (10.8%) stddev-sans-first:606.74 12:03:44 INFO - PROCESS | 11518 | Values: 3267.4 3315.9 3329.8 3356.1 3386.8 5544.3 5553.8 5555.1 5563.4 5567.1 5560.1 5580.1 5582.1 5582.9 5616.2 4995.3 5000.5 5081.4 5115.7 5161.3 5005.8 5067.6 5073.5 5105.2 5111.5 5182.4 5182.7 5219.7 5226.5 5229.5 5201.6 5208.0 5216.2 5220.9 5254.0 4983.2 5013.4 5076.5 5101.5 5113.8 5424.6 5448.9 5452.0 5466.1 5489.3 5868.6 5900.0 5910.5 5920.9 5921.4 5915.0 5976.8 6064.4 6124.0 6135.9 5586.7 5596.7 5598.3 5598.7 5611.2 6028.5 6066.7 6070.2 6084.2 6087.7 5793.2 5955.6 6025.3 6055.0 6058.2 6089.5 6102.0 6107.0 6113.0 6115.0 5906.1 6000.7 6067.6 6076.4 6080.4 5949.4 6019.5 6036.8 6063.0 6072.0 4554.9 4556.1 4557.8 4572.7 4584.1 4012.2 4066.1 4069.3 4074.8 4075.5 5638.8 5656.2 5671.5 5679.2 5694.5 5960.3 5973.5 5979.8 5982.8 5992.1 5564.2 5649.9 5680.6 5761.4 5876.2 5051.3 5053.7 5062.8 5062.9 5100.8 6064.5 6069.6 6077.7 6106.9 6125.8 5916.8 6040.3 6046.2 6109.4 6116.1 6143.2 6204.8 6208.0 6208.8 6213.8 5883.1 5883.9 5895.6 5897.4 5904.9 5766.5 6097.8 6127.7 6139.2 6160.1 5933.1 5949.3 5961.6 5966.5 5969.2 5810.7 5964.2 5982.3 5982.8 6003.3 5804.6 5841.8 5843.2 5877.8 5892.4 5870.4 5908.5 5912.9 5919.5 5942.4 5724.5 5767.0 5784.1 5787.8 5832.1 12:03:44 INFO - PROCESS | 11518 | 12:03:44 INFO - PROCESS | 11518 | [#1] ext.html Cycles:180 Average:54182.51 Median:358242.00 stddev:97909.35 (27.3%) stddev-sans-first:98101.55 12:03:44 INFO - PROCESS | 11518 | Values: 665.0 673.2 682.3 731.5 734.8 35066.6 36081.1 39890.2 40858.4 41013.8 45040.5 45585.0 45679.3 45737.0 45741.8 8112.1 8831.2 9009.9 9014.7 9015.9 10816.2 11095.8 11104.6 11105.8 11109.3 10668.3 10721.9 10737.1 10742.2 10751.0 10602.8 10663.3 10669.9 10672.2 10678.0 10268.6 10393.8 10416.7 10423.5 10431.7 43757.0 43914.8 44143.8 44153.8 44258.3 3680.4 3738.4 3745.3 3803.3 3885.0 30154.1 30359.4 30780.0 30792.2 30969.5 4426.5 4440.6 4497.3 4576.4 4639.9 214058.0 215049.0 215225.9 215228.0 215739.0 61813.0 61967.7 62074.4 62119.4 62146.7 68957.7 70817.6 70853.0 70888.6 70976.0 19105.4 19312.0 19339.4 19370.4 19374.9 13337.9 14581.7 14910.9 14927.4 14942.9 19731.3 19833.6 19923.2 19948.1 20015.3 7249.9 7266.4 7320.6 7475.6 7502.5 1069.1 1110.4 1160.7 1166.8 1202.7 33549.8 33868.5 33926.7 33996.2 34172.1 1216.2 1226.4 1258.7 1282.5 1291.7 17961.6 18394.8 19237.7 19332.0 19370.8 484756.0 484878.0 488859.0 489240.0 490336.0 63433.7 64149.7 64153.7 64194.0 64211.7 1409.3 1471.9 1530.6 1552.2 1620.1 30275.7 32201.0 32871.0 33092.7 33174.7 51307.5 52103.0 52108.7 52112.2 52120.5 355757.0 356627.0 357616.0 358154.0 358330.0 28905.3 30048.4 30231.8 30325.0 30359.2 49040.3 49338.8 49415.5 49445.5 50503.0 41442.8 42574.8 42721.6 43268.4 43597.8 40469.2 41510.4 41905.4 42271.0 42296.6 42509.1 43047.0 43568.1 43603.0 43608.3 35570.3 36677.3 36961.6 37110.0 37345.3 28566.3 28669.4 28679.3 28683.6 28803.4 12:03:44 INFO - PROCESS | 11518 | 12:03:44 INFO - PROCESS | 11518 | [#2] jquery.html Cycles:180 Average:29598.01 Median:12662.27 stddev:84821.00 (669.9%) stddev-sans-first:85030.64 12:03:44 INFO - PROCESS | 11518 | Values: 414.4 423.3 423.8 424.6 435.3 17987.4 18332.3 18911.1 19022.6 19747.8 19027.9 19310.0 19705.0 20626.5 20643.4 5661.0 5709.3 5759.8 5762.8 5887.9 5714.8 5726.8 5738.3 5745.5 5762.0 5553.4 5712.4 5727.5 5763.3 5876.8 5778.7 5833.4 5845.8 5847.6 5852.3 5233.7 5244.9 5281.5 5291.0 5291.4 23128.3 23296.4 23753.9 23771.2 23819.9 2366.5 2447.9 2620.3 3092.3 3306.3 10326.9 10500.4 10590.8 11718.7 14654.1 1805.3 2010.5 2054.1 2094.0 2134.8 76147.6 76303.6 79595.0 79668.0 81103.2 11589.0 11646.0 11737.1 11805.6 11902.6 16232.7 16427.8 16468.1 16517.8 16587.5 8662.4 8671.8 8673.8 8759.5 8774.1 8259.5 8284.7 8315.0 8430.3 8470.8 5012.9 5053.4 5076.2 5102.9 5134.0 2090.7 2098.8 2139.0 2153.9 2196.2 1021.5 1030.9 1130.0 1137.8 1139.1 18539.0 18667.6 18813.6 19353.9 19655.0 1064.7 1097.8 1105.9 1116.9 1126.1 10323.8 10920.0 10978.7 11047.3 11186.7 504703.0 513699.0 517944.0 521821.0 524800.0 50020.5 90400.5 90620.5 93745.5 95585.5 1081.7 1122.7 1127.8 1140.9 1158.8 17182.0 17200.6 17202.1 17385.5 17480.9 29770.6 39012.8 40721.8 41540.0 42141.0 55682.0 56183.7 56232.7 57296.0 57381.7 8450.1 8463.4 8477.7 8506.3 8520.0 9140.9 13503.1 13887.5 14052.5 14265.4 11775.0 12356.6 12369.6 12438.4 12478.1 11693.7 11962.5 12015.2 12039.9 12144.3 12164.2 12312.5 12380.8 12433.0 12529.7 8703.6 8916.9 9154.9 12269.4 13534.8 11791.9 11861.2 12042.5 12724.9 12819.9 12:03:44 INFO - PROCESS | 11518 | 12:03:44 INFO - PROCESS | 11518 | [#3] mootools.html Cycles:180 Average:5534.23 Median:5032.56 stddev:2960.67 (58.8%) stddev-sans-first:2952.98 12:03:44 INFO - PROCESS | 11518 | Values: 1440.0 1531.9 1600.1 1785.8 1873.5 7844.8 8052.8 8057.0 8058.3 8062.8 7902.8 8063.2 8080.6 8089.0 8094.4 2379.7 2401.2 2404.1 2406.8 2417.3 2420.3 2455.3 2457.3 2459.6 2472.2 2357.1 2384.0 2407.4 2428.5 2459.9 2313.2 2381.9 2399.1 2399.7 2399.9 2382.7 2413.4 2435.9 2438.2 2444.8 7169.0 7797.1 8250.9 8297.9 8298.0 5090.9 5165.0 5197.9 5204.9 5205.8 3499.6 3531.2 3557.3 3623.3 3659.2 1245.7 1306.8 1325.8 1355.3 2227.2 10773.3 10850.8 10854.0 10868.7 10891.0 4314.9 4365.0 4380.0 4416.9 4419.9 8838.2 8845.2 8847.1 8847.8 8848.5 5128.0 5138.4 5212.1 5215.4 5217.6 4851.6 4881.2 4885.0 4891.9 4893.8 3520.4 3708.2 3727.7 3737.2 3739.7 1097.2 1119.2 1124.0 1132.1 1132.9 919.9 989.8 997.3 1023.1 1041.6 5603.8 5624.6 5657.9 5730.6 5792.5 1000.5 1011.9 1033.2 1051.1 1055.2 3983.8 4001.4 4013.9 4025.5 4036.5 9904.3 10371.4 10380.8 10388.6 10421.8 10314.5 10471.2 10472.4 10486.2 10487.8 8043.2 8073.9 8179.9 8182.1 8189.3 5526.3 5597.5 5684.3 5724.8 5800.2 8955.5 9249.3 9339.1 9339.7 9342.9 9387.4 9446.0 9579.6 9590.7 9652.2 7405.3 7499.1 7522.5 7523.2 7535.9 8014.6 8061.2 8062.3 8069.4 8080.6 7374.7 7403.9 7417.9 7495.7 7559.5 7399.3 7409.0 7413.3 7489.9 7520.1 6767.9 6889.2 6917.2 6999.2 7005.3 4095.7 5029.3 5068.7 5140.2 5144.3 4994.5 5007.1 5015.2 5035.8 5038.1 12:03:44 INFO - PROCESS | 11518 | 12:03:44 INFO - PROCESS | 11518 | [#4] prototype.html Cycles:180 Average:5586.75 Median:6441.78 stddev:1674.20 (26.0%) stddev-sans-first:1631.85 12:03:44 INFO - PROCESS | 11518 | Values: 335.9 347.3 348.3 362.3 362.4 6091.2 6228.9 6305.8 6334.2 6378.9 6202.1 6323.7 6331.6 6337.5 6339.1 4845.7 4869.6 4872.3 4881.3 4885.8 4636.5 4686.6 4776.9 4871.4 4884.5 4751.0 4791.7 4796.6 4808.4 4817.3 4781.5 4784.7 4799.5 4799.9 4802.1 4206.1 4210.6 4220.3 4224.0 4229.2 6072.4 6076.3 6081.1 6085.1 6097.3 5384.7 5584.6 5589.4 5597.9 5612.6 6619.5 6639.9 6647.0 6650.7 6653.5 4592.9 4600.4 4602.4 4605.1 4609.0 6865.7 6933.5 6938.7 6944.3 6945.7 4687.2 4716.6 4718.6 4722.1 4722.5 4708.4 4771.9 4774.1 4777.1 4783.0 5487.9 5523.5 5539.3 5562.1 5574.1 6622.3 6655.9 6669.6 6673.1 6685.1 1639.9 1691.8 1706.0 1736.8 1740.8 1155.9 1176.1 1183.7 1184.9 1190.9 6442.3 6457.5 6463.6 6464.5 6466.8 6812.4 6813.7 6814.1 6817.8 6839.4 6441.3 6443.7 6446.0 6452.8 6487.4 3661.7 3682.6 3691.0 3692.6 3693.1 6950.4 7118.4 7124.6 7124.8 7128.4 6970.9 6989.2 7000.0 7003.6 7004.3 7075.6 7081.5 7096.4 7096.5 7096.8 6820.9 6826.3 6826.7 6834.6 6843.1 6548.0 6698.8 6728.9 6740.5 6744.5 7044.3 7076.2 7086.2 7091.2 7118.2 4879.0 4882.6 4888.0 4895.3 4895.6 6704.5 6752.4 6848.5 6849.6 6851.2 6696.6 6699.6 6736.3 6738.6 6758.0 6728.0 6734.7 6751.3 6754.4 6760.1 6629.5 6635.3 6635.3 6637.7 6646.2 6561.7 6794.0 6801.9 6830.7 6844.8 6584.7 6634.1 6634.6 6645.8 6647.3 12:03:44 INFO - PROCESS | 11518 | 12:03:44 INFO - PROCESS | 11518 | [#5] yui.html Cycles:180 Average:15234.87 Median:4741.89 stddev:17885.99 (377.2%) stddev-sans-first:17903.39 12:03:44 INFO - PROCESS | 11518 | Values: 815.8 817.9 840.8 908.1 914.5 13760.1 14227.1 14515.4 14600.7 14733.3 13812.4 13873.7 13928.3 14008.4 14024.1 882.7 898.0 903.9 904.4 905.1 754.1 887.6 898.0 901.6 907.1 934.2 934.7 936.4 938.9 941.0 790.3 932.8 934.0 934.6 935.6 685.2 689.4 689.5 690.6 691.2 14467.5 14480.1 14574.4 14724.8 14732.7 13506.5 14275.4 14418.7 14433.0 14653.2 11290.9 11360.6 11626.2 11662.2 11774.6 3821.4 3843.9 3864.5 3892.5 3912.3 52925.9 53587.0 54096.5 57169.0 57306.7 11239.3 11405.3 11420.7 11622.8 12252.5 19973.6 20001.0 20018.9 20070.4 20088.5 8439.5 8450.7 8526.2 8530.6 8702.1 4682.2 4751.1 4878.0 4894.3 4967.9 3604.7 3634.9 3652.5 3658.2 3660.6 668.6 684.6 685.6 694.3 694.6 670.0 698.5 713.3 784.5 810.1 9724.2 10129.0 10169.9 10182.7 10238.8 711.3 754.9 816.3 816.5 819.9 4204.2 4428.6 4527.2 4641.1 4732.7 63886.0 63982.5 64279.7 64293.7 65107.0 54804.0 57865.1 58780.7 58825.7 59049.7 50704.7 51153.2 51213.0 52030.7 52526.7 8627.7 8681.0 9056.5 9070.6 9290.2 38194.4 38764.0 38818.0 39227.4 40003.8 45617.5 48897.0 49009.3 49887.8 50171.5 11565.8 11597.8 11631.0 11693.4 11872.8 12317.8 12453.7 12831.7 12973.3 13360.5 11456.2 11717.2 11862.6 11916.4 12005.0 11932.9 12020.2 12025.8 12035.0 12651.7 11530.7 11550.4 11557.1 11560.3 11798.7 9662.8 9816.1 9946.9 9951.2 10371.3 9660.8 10057.2 10071.4 10072.9 10118.2 12:03:44 INFO - PROCESS | 11518 | -------- Summary: end -------- 12:03:44 INFO - PROCESS | 11518 | 12:03:44 INFO - TEST-INFO | 11518: exit 0 12:03:45 INFO - TEST-OK | dromaeo_css | took 1110845ms 12:03:45 INFO - TEST-START | kraken 12:03:45 INFO - operating with platform_type : linux_ 12:03:45 INFO - Initialising browser for kraken test... 12:03:45 INFO - TEST-INFO | started process 11713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBR1xfD/profile http://localhost:40880/getInfo.html) 12:03:48 INFO - PROCESS | 11713 | __metrics Screen width/height:1600/1200 12:03:48 INFO - PROCESS | 11713 | colorDepth:24 12:03:48 INFO - PROCESS | 11713 | Browser inner width/height: 1024/697 12:03:48 INFO - PROCESS | 11713 | __metrics 12:03:50 ERROR - PROCESS | 11713 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:03:50 INFO - TEST-INFO | 11713: exit 0 12:03:50 INFO - Browser initialized. 12:03:50 INFO - Running cycle 1/1 for kraken test... 12:03:50 INFO - TEST-INFO | started process 11806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBR1xfD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:02 INFO - PROCESS | 11806 | RSS: Main: 139640832 12:04:02 INFO - PROCESS | 11806 | 12:04:04 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40880/tests/kraken/driver.html?testName=audio-beat-detection) 12:04:05 INFO - PROCESS | 11806 | RSS: Main: 198111232 12:04:05 INFO - PROCESS | 11806 | 12:04:08 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40880/tests/kraken/driver.html?testName=audio-dft) 12:04:09 INFO - PROCESS | 11806 | RSS: Main: 185356288 12:04:09 INFO - PROCESS | 11806 | 12:04:11 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40880/tests/kraken/driver.html?testName=audio-fft) 12:04:12 INFO - PROCESS | 11806 | RSS: Main: 274939904 12:04:12 INFO - PROCESS | 11806 | 12:04:14 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40880/tests/kraken/driver.html?testName=audio-oscillator) 12:04:15 INFO - PROCESS | 11806 | RSS: Main: 180486144 12:04:15 INFO - PROCESS | 11806 | 12:04:17 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:04:17 INFO - PROCESS | 11806 | RSS: Main: 179793920 12:04:17 INFO - PROCESS | 11806 | 12:04:20 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40880/tests/kraken/driver.html?testName=imaging-darkroom) 12:04:21 INFO - PROCESS | 11806 | RSS: Main: 214044672 12:04:21 INFO - PROCESS | 11806 | 12:04:24 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40880/tests/kraken/driver.html?testName=imaging-desaturate) 12:04:25 INFO - PROCESS | 11806 | RSS: Main: 214843392 12:04:25 INFO - PROCESS | 11806 | 12:04:28 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40880/tests/kraken/driver.html?testName=json-parse-financial) 12:04:28 INFO - PROCESS | 11806 | RSS: Main: 213385216 12:04:28 INFO - PROCESS | 11806 | 12:04:30 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:04:30 INFO - PROCESS | 11806 | RSS: Main: 196804608 12:04:30 INFO - PROCESS | 11806 | 12:04:32 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40880/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:04:33 INFO - PROCESS | 11806 | RSS: Main: 199696384 12:04:33 INFO - PROCESS | 11806 | 12:04:35 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:04:35 INFO - PROCESS | 11806 | RSS: Main: 209334272 12:04:35 INFO - PROCESS | 11806 | 12:04:38 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:04:38 INFO - PROCESS | 11806 | RSS: Main: 217059328 12:04:38 INFO - PROCESS | 11806 | 12:04:41 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:04:41 INFO - PROCESS | 11806 | RSS: Main: 213045248 12:04:41 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | Cycle 1(1): loaded http://localhost:40880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40880/tests/kraken/driver.html?testName=ai-astar) 12:04:43 INFO - PROCESS | 11806 | RSS: Main: 273293312 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | __start_tp_report 12:04:43 INFO - PROCESS | 11806 | _x_x_mozilla_page_load 12:04:43 INFO - PROCESS | 11806 | _x_x_mozilla_page_load_details 12:04:43 INFO - PROCESS | 11806 | |i|pagename|runs| 12:04:43 INFO - PROCESS | 11806 | |0;ai-astar;114;113;111;112;112;111;105;110;110;109 12:04:43 INFO - PROCESS | 11806 | |1;audio-beat-detection;155;127;156;177;134;162;152;128;197;127 12:04:43 INFO - PROCESS | 11806 | |2;audio-dft;161;161;160;162;164;162;162;161;160;161 12:04:43 INFO - PROCESS | 11806 | |3;audio-fft;75;80;73;182;73;75;73;76;164;74 12:04:43 INFO - PROCESS | 11806 | |4;audio-oscillator;93;93;149;92;92;92;141;91;93;155 12:04:43 INFO - PROCESS | 11806 | |5;imaging-gaussian-blur;117;117;116;117;118;116;117;116;117;117 12:04:43 INFO - PROCESS | 11806 | |6;imaging-darkroom;146;146;145;145;146;145;145;145;145;146 12:04:43 INFO - PROCESS | 11806 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;95 12:04:43 INFO - PROCESS | 11806 | |8;json-parse-financial;57;54;54;55;54;55;56;70;53;53 12:04:43 INFO - PROCESS | 11806 | |9;json-stringify-tinderbox;58;61;58;58;59;58;59;58;58;58 12:04:43 INFO - PROCESS | 11806 | |10;stanford-crypto-aes;74;79;74;72;75;74;73;73;74;73 12:04:43 INFO - PROCESS | 11806 | |11;stanford-crypto-ccm;116;115;115;113;114;112;115;114;127;115 12:04:43 INFO - PROCESS | 11806 | |12;stanford-crypto-pbkdf2;165;160;163;160;162;162;164;157;158;159 12:04:43 INFO - PROCESS | 11806 | |13;stanford-crypto-sha256-iterative;69;67;66;67;67;67;67;66;67;65 12:04:43 INFO - PROCESS | 11806 | __end_tp_report 12:04:43 INFO - PROCESS | 11806 | __start_cc_report 12:04:43 INFO - PROCESS | 11806 | _x_x_mozilla_cycle_collect,1573 12:04:43 INFO - PROCESS | 11806 | __end_cc_report 12:04:43 INFO - PROCESS | 11806 | __startTimestamp1467054283921__endTimestamp 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | ------- Summary: start ------- 12:04:43 INFO - PROCESS | 11806 | Number of tests: 14 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.50 (2.2%) stddev-sans-first:2.35 12:04:43 INFO - PROCESS | 11806 | Values: 114.0 113.0 111.0 112.0 112.0 111.0 105.0 110.0 110.0 109.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:155.50 stddev:23.39 (15.0%) stddev-sans-first:24.77 12:04:43 INFO - PROCESS | 11806 | Values: 155.0 127.0 156.0 177.0 134.0 162.0 152.0 128.0 197.0 127.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 12:04:43 INFO - PROCESS | 11806 | Values: 161.0 161.0 160.0 162.0 164.0 162.0 162.0 161.0 160.0 161.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#3] audio-fft Cycles:10 Average:94.50 Median:74.50 stddev:41.64 (55.9%) stddev-sans-first:43.57 12:04:43 INFO - PROCESS | 11806 | Values: 75.0 80.0 73.0 182.0 73.0 75.0 73.0 76.0 164.0 74.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.00 stddev:27.28 (29.7%) stddev-sans-first:28.31 12:04:43 INFO - PROCESS | 11806 | Values: 93.0 93.0 149.0 92.0 92.0 92.0 141.0 91.0 93.0 155.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 12:04:43 INFO - PROCESS | 11806 | Values: 117.0 117.0 116.0 117.0 118.0 116.0 117.0 116.0 117.0 117.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 12:04:43 INFO - PROCESS | 11806 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:04:43 INFO - PROCESS | 11806 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:5.04 (9.2%) stddev-sans-first:5.34 12:04:43 INFO - PROCESS | 11806 | Values: 57.0 54.0 54.0 55.0 54.0 55.0 56.0 70.0 53.0 53.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.00 stddev:0.97 (1.7%) stddev-sans-first:1.01 12:04:43 INFO - PROCESS | 11806 | Values: 58.0 61.0 58.0 58.0 59.0 58.0 59.0 58.0 58.0 58.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:1.91 (2.6%) stddev-sans-first:2.03 12:04:43 INFO - PROCESS | 11806 | Values: 74.0 79.0 74.0 72.0 75.0 74.0 73.0 73.0 74.0 73.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:115.00 stddev:4.17 (3.6%) stddev-sans-first:4.42 12:04:43 INFO - PROCESS | 11806 | Values: 116.0 115.0 115.0 113.0 114.0 112.0 115.0 114.0 127.0 115.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:162.00 stddev:2.62 (1.6%) stddev-sans-first:2.35 12:04:43 INFO - PROCESS | 11806 | Values: 165.0 160.0 163.0 160.0 162.0 162.0 164.0 157.0 158.0 159.0 12:04:43 INFO - PROCESS | 11806 | 12:04:43 INFO - PROCESS | 11806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:0.73 12:04:43 INFO - PROCESS | 11806 | Values: 69.0 67.0 66.0 67.0 67.0 67.0 67.0 66.0 67.0 65.0 12:04:43 INFO - PROCESS | 11806 | -------- Summary: end -------- 12:04:43 INFO - PROCESS | 11806 | 12:04:44 INFO - TEST-INFO | 11806: exit 0 12:04:44 INFO - TEST-OK | kraken | took 59946ms 12:04:44 INFO - SUITE-END | took 1170s 12:04:45 INFO - Completed test suite (00:19:30) 12:04:45 INFO - javascript benchmark 12:04:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3267.395531826612, 3315.8839440619577, 3329.750268729846, 3356.110630682868, 3386.8306584670777, 5544.306961629796, 5553.8333849984465, 5555.138953462209, 5563.443655634434, 5567.109262517998, 5560.082586373243, 5580.135079062752, 5582.051051321275, 5582.888342233153, 5616.157576363547, 4995.275685025669, 5000.549950504454, 5081.364829396325, 5115.667481613702, 5161.303224064741, 5005.849824505271, 5067.619928505358, 5073.543381095719, 5105.157648987913, 5111.488851114896, 5182.378114626231, 5182.714950677711, 5219.686818790866, 5226.477352264781, 5229.450907654698, 5201.557867581241, 5207.984443033591, 5216.191490319006, 5220.895582088375, 5253.9737301313635, 4983.177775667011, 5013.398392192924, 5076.492350764931, 5101.489851014906, 5113.821016264413, 5424.620276580641, 5448.863778405532, 5451.972740136274, 5466.098093814516, 5489.258950041733, 5868.618539794899, 5900.0, 5910.497607703351, 5920.851978700523, 5921.407859214087, 5915.0, 5976.820695379146, 6064.36324185963, 6123.969380153116, 6135.938640613582, 5586.664800112007, 5596.684779076913, 5598.272224610815, 5598.720063996825, 5611.2144299798065, 6028.5478589106, 6066.726997285133, 6070.180525629072, 6084.178635884187, 6087.726052327655, 5793.2179155814265, 5955.642661440241, 6025.3372129065765, 6055.0, 6058.182145410401, 6089.48239399656, 6101.96949015261, 6106.969465152734, 6112.99135642614, 6115.0215965446205, 5906.055031195074, 6000.669963152069, 6067.635941843503, 6076.422739839708, 6080.391960803884, 5949.405059494103, 6019.458248757633, 6036.849078773066, 6062.969685151546, 6071.9696401518595, 4554.908901821945, 4556.088782243564, 4557.840475583339, 4572.725636461823, 4584.129015487047, 4012.1975604878558, 4066.1257829566784, 4069.2878746219294, 4074.7758873261664, 4075.5313138989395, 5638.802641907513, 5656.151577263443, 5671.489565939085, 5679.2333035040565, 5694.5159661428415, 5960.3443621202505, 5973.492253158443, 5979.8206053817585, 5982.790602328898, 5992.13114098462, 5564.165375193753, 5649.915251271234, 5680.630759000652, 5761.3950535194035, 5876.177335173079, 5051.318072060299, 5053.747312634354, 5062.797488100508, 5062.873428164326, 5100.821471248489, 6064.4845188158615, 6069.575129740964, 6077.696115194222, 6106.938930610726, 6125.754969801247, 5916.822495325061, 6040.305364882919, 6046.2139921809885, 6109.435031337353, 6116.082587611894, 6143.232095988002, 6204.81385558434, 6208.037754148114, 6208.844778880564, 6213.751449942132, 5883.058710606282, 5883.911741323969, 5895.557833162444, 5897.3807750185615, 5904.881902362014, 5766.509846662912, 6097.817065488042, 6127.708789264132, 6139.185504090546, 6160.106784516131, 5933.050711886078, 5949.315828679757, 5961.642301461926, 5966.463018328372, 5969.194158788681, 5810.73851676684, 5964.194833697396, 5982.341942386421, 5982.760689572542, 6003.309619393651, 5804.593678442468, 5841.824745257649, 5843.211166492469, 5877.794277200277, 5892.381299963442, 5870.354261031198, 5908.527317814651, 5912.940870591239, 5919.467247947706, 5942.405759424023, 5724.513416359656, 5767.0, 5784.1034639630925, 5787.797427090031, 5832.096025116114], "value": 5536.122034029633, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.0224170469409, 673.1787219592097, 682.3006418421121, 731.4989232375822, 734.819969107569, 35066.649333506655, 36081.0979725507, 39890.202195956066, 40858.38712419309, 41013.794931025375, 45040.549594504046, 45585.0, 45679.31481027779, 45737.0, 45741.77129114358, 8112.107668156527, 8831.205191532745, 9009.909900901006, 9014.68448604299, 9015.864762028576, 10816.188785841054, 11095.778084438307, 11104.55581776728, 11105.83341249882, 11109.277896936714, 10668.30656007361, 10721.946390268038, 10737.087347575465, 10742.248042637018, 10751.0, 10602.840957385646, 10663.306885052447, 10669.946650266776, 10672.199585031114, 10678.0, 10268.640597579124, 10393.79212415755, 10416.739581510446, 10423.530941107669, 10431.687049388454, 43757.0, 43914.78042609798, 44143.77928110371, 44153.77923110364, 44258.33612495815, 3680.3743363628246, 3738.401855703102, 3745.3071181831447, 3803.2583646189005, 3884.9611503885167, 30154.09537713872, 30359.392812143855, 30780.0, 30792.230194245098, 30969.535456968162, 4426.513083560806, 4440.622547083502, 4497.257952437843, 4576.427946506687, 4639.884002899921, 214058.0, 215049.0, 215225.9238703812, 215228.0, 215739.0, 61813.0, 61967.690161548904, 62074.379256207765, 62119.44701382411, 62146.68926655338, 68957.65521172361, 70817.64591177113, 70853.0, 70888.64555677188, 70976.0, 19105.426837194907, 19312.03439828003, 19339.4198174055, 19370.4188874334, 19374.90312548428, 13337.866621333857, 14581.708365832625, 14910.925445372704, 14927.40290388394, 14942.850571494146, 19731.309404170785, 19833.60332793336, 19923.20307187725, 19948.102335394942, 20015.299464518674, 7249.891251631229, 7266.418686505067, 7320.597367144752, 7475.588842613708, 7502.512336698097, 1069.0859315285475, 1110.4003837927428, 1160.6797416743564, 1166.8133098704166, 1202.7414105967084, 33549.83225083908, 33868.49197262043, 33926.66073339284, 33996.150096247795, 34172.14569635779, 1216.197309775544, 1226.3868065967017, 1258.6658142369117, 1282.4613662261872, 1291.651254161371, 17961.550961225814, 18394.7926248851, 19237.711434328496, 19332.0, 19370.80629193718, 484756.0, 484878.0, 488859.0, 489240.0, 490336.0, 63433.68283158647, 64149.67925160344, 64153.679231604474, 64194.03708944369, 64211.678941604994, 1409.302395314326, 1471.9411223550937, 1530.5637893200385, 1552.1773460066183, 1620.0765563628618, 30275.697243027287, 32201.0, 32871.0, 33092.669073308956, 33174.66825331812, 51307.48692513027, 52103.0, 52108.73945630248, 52112.21831672604, 52120.478795211566, 355757.0, 356627.0, 357616.0, 358154.0, 358330.0, 28905.277368065126, 30048.3990320188, 30231.848840755654, 30325.0, 30359.241018974702, 49040.2643960348, 49338.75330623468, 49415.50584494109, 49445.50554494409, 50502.979880804356, 41442.792786035876, 42574.78712606417, 42721.57278427176, 43268.35097473604, 43597.782011089745, 40469.1906161881, 41510.37734433926, 41905.37141942934, 42271.0, 42296.57703422927, 42509.14981700287, 43047.0, 43568.12863742644, 43603.0, 43608.34587481254, 35570.288594228485, 36677.26645467129, 36961.61640184119, 37110.0, 37345.253094937405, 28566.285842854097, 28669.426611467235, 28679.283017924718, 28683.56974645424, 28803.423931521673], "value": 20996.109393005456, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.44257473697877, 423.27197220780266, 423.8389412023433, 424.6369354202159, 435.25354017859377, 17987.37044203453, 18332.266709331627, 18911.148998295077, 19022.61954760904, 19747.802521974776, 19027.90486047571, 19310.0, 19705.0, 20626.48433789156, 20643.38069857903, 5660.9716951415185, 5709.31488221414, 5759.769609215627, 5762.769489220447, 5887.88224235515, 5714.771409143629, 5726.770929162829, 5738.254026976487, 5745.511631511326, 5761.971190144043, 5553.389127196006, 5712.371639119693, 5727.484526392624, 5763.279590051244, 5876.794312199074, 5778.682172480512, 5833.445822646841, 5845.795397161121, 5847.619904706202, 5852.326982397015, 5233.738313084331, 5244.895102097975, 5281.471852814688, 5290.973545132289, 5291.391489978663, 23128.306150815504, 23296.417589560227, 23753.88123059391, 23771.1680091196, 23819.88090059556, 2366.4675448024227, 2447.865367404792, 2620.2794231586277, 3092.304231547906, 3306.2560923792194, 10326.896731032668, 10500.369977801356, 10590.788184236271, 11718.707032324175, 14654.120752754869, 1805.2869116698962, 2010.5275260313815, 2054.0551346380685, 2093.9895300523553, 2134.7545032321327, 76147.61926190389, 76303.61848190779, 79595.0, 79667.99999999942, 81103.18896811074, 11589.0, 11646.0, 11737.06103511717, 11805.645830625095, 11902.583409580624, 16232.675346493004, 16427.753583696016, 16468.0942548161, 16517.834821651628, 16587.502374928772, 8662.436941598777, 8671.826563468696, 8673.826523469621, 8759.518226497605, 8774.078721734253, 8259.463134896212, 8284.71003514874, 8314.958425207957, 8430.283425908867, 8470.830583388297, 5012.924806127911, 5053.393592768891, 5076.213186956028, 5102.923456148161, 5134.0, 2090.7177531033117, 2098.7901209879196, 2138.967915481269, 2153.8707677539396, 2196.2313190383557, 1021.5045702834119, 1030.8711411073616, 1129.9717257295822, 1137.8293256011664, 1139.0944199361527, 18539.0, 18667.626647466976, 18813.638113137964, 19353.90323048404, 19655.0, 1064.7178497698117, 1097.7639807441278, 1105.922585419029, 1116.8827273136367, 1126.0541145437871, 10323.793524129474, 10920.0, 10978.670639880816, 11047.281926674741, 11186.720331991603, 504703.0, 513699.0, 517944.0, 521821.0, 524800.0, 50020.49979500231, 90400.5479972596, 90620.54689726509, 93745.53127234457, 95585.5220723892, 1081.6809041332826, 1122.7080958950569, 1127.785720713062, 1140.9087273018138, 1158.8145896656663, 17182.0, 17200.569985750455, 17202.13989300555, 17385.47843564695, 17480.863743856607, 29770.553441697957, 39012.80493597514, 40721.79639101786, 41540.0, 42141.0, 55682.0, 56183.71908140433, 56232.718836405555, 57296.0, 57381.71309143428, 8450.070492245972, 8463.407561470638, 8477.73607161235, 8506.276966457921, 8520.0, 9140.908590914272, 13503.12229705066, 13887.513937012156, 14052.513172989356, 14265.358058887168, 11775.0, 12356.567520136752, 12369.567065152676, 12438.440270187682, 12478.064145189328, 11693.707657308636, 11962.521499139937, 12015.219010764273, 12039.879601204226, 12144.332061736335, 12164.209326393757, 12312.50749970027, 12380.81428778587, 12433.0, 12529.749405012031, 8703.564821759013, 8916.86624700643, 9154.908450915405, 12269.386530673251, 13534.796978045533, 11791.941040294743, 11861.169718119649, 12042.458089386173, 12724.936375318064, 12819.935900320439], "value": 9562.389303559892, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.0351764317907, 1531.9463818766344, 1600.1199340362798, 1785.8035616082236, 1873.4660621722812, 7844.803879902998, 8052.798680033002, 8056.959715201423, 8058.274755272032, 8062.798430039252, 7902.841943161134, 8063.193680631948, 8080.636371363288, 8089.0293164820305, 8094.433389662726, 2379.690640216769, 2401.1835975768236, 2404.0984630763464, 2406.819488538367, 2417.2748175547354, 2420.3344080377947, 2455.26342097371, 2457.2628211536558, 2459.56957532432, 2472.196536125757, 2357.127862690807, 2384.0344660412475, 2407.374082738492, 2428.490017096403, 2459.8770061496944, 2313.248194336847, 2381.880905954704, 2399.0523743121457, 2399.652050452692, 2399.892004859768, 2382.725986511556, 2413.3966508372905, 2435.866027368494, 2438.1953955194745, 2444.828861979662, 7169.0, 7797.064352277763, 8250.917490825135, 8297.875531867026, 8297.95851020747, 5090.9236361454605, 5165.0, 5197.922031169535, 5204.921926171072, 5205.843824685266, 3499.61504234534, 3531.1525233943926, 3557.3063252665743, 3623.3477973964677, 3659.176685245825, 1245.7446223524155, 1306.8431788185383, 1325.7945018522048, 1355.3494322725048, 2227.151598159915, 10773.299735517245, 10850.837237441445, 10854.0, 10868.728281792939, 10891.01980821722, 4314.89212769677, 4364.978175109168, 4379.97070688388, 4416.867493975186, 4419.9337009944875, 8838.204561589488, 8845.24815390699, 8847.071057538995, 8847.823043539092, 8848.46909185451, 5128.025675121715, 5138.3833939927445, 5212.087884620177, 5215.374155101412, 5217.556507696812, 4851.611871050308, 4881.219004959261, 4885.047415753965, 4891.853244402673, 4893.828715994994, 3520.436730123168, 3708.2212735325343, 3727.683146932541, 3737.177820879402, 3739.719521035933, 1097.2209731090854, 1119.1997721629075, 1123.9606613768642, 1132.0999805154922, 1132.9037031852386, 919.8712180294764, 989.7624570103123, 997.2570435025953, 1023.0690072034562, 1041.5677493839971, 5603.80386686464, 5624.578156638268, 5657.9434205658235, 5730.570207234474, 5792.507636850831, 1000.4947501511836, 1011.8785745710414, 1033.1734612310122, 1051.0540513537876, 1055.1822337688352, 3983.8406463741703, 4001.4397984282223, 4013.8795836124964, 4025.5169379674626, 4036.4752582164133, 9904.257180711475, 10371.429571373495, 10380.844287335696, 10388.636397726043, 10421.843672344921, 10314.48427578618, 10471.16230701542, 10472.371657700562, 10486.213533984828, 10487.842682359771, 8043.235892590194, 8073.878891816627, 8179.854820325159, 8182.099969003405, 8189.344852411912, 5526.309211348582, 5597.468240517144, 5684.346300175533, 5724.771009159587, 5800.1589769484035, 8955.462672239686, 9249.260059195114, 9339.066093390607, 9339.673111441067, 9342.859857102014, 9387.436753794795, 9446.0, 9579.616815327308, 9590.712278631652, 9652.227821774382, 7405.259474052552, 7499.100107986858, 7522.473426860067, 7523.172451030492, 7535.924640753522, 8014.639341229776, 8061.1938806118915, 8062.314703250289, 8069.3544516439715, 8080.555569443737, 7374.6681399336085, 7403.888941665987, 7417.865114359979, 7495.662695178621, 7559.508631938907, 7399.260073992557, 7409.036825212688, 7413.2957369049855, 7489.8876516851205, 7520.097588289222, 6767.93232067673, 6889.173299204128, 6917.169939607279, 6999.160100787938, 7005.334493223136, 4095.7133000690856, 5029.346184995927, 5068.695878247317, 5140.151874940593, 5144.279800827962, 4994.525520075587, 5007.098722230034, 5015.247712843103, 5035.773390197377, 5038.14351560243], "value": 4549.892589419996, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.89923023093064, 347.32445393709236, 348.30339321357275, 362.3278817792994, 362.4418395670667, 6091.208142941423, 6228.875422491547, 6305.810825675226, 6334.176557047583, 6378.872422551552, 6202.100695399165, 6323.715432805523, 6331.55679102463, 6337.461315788163, 6339.11252424661, 4845.733484658343, 4869.561739443449, 4872.317875497433, 4881.34101896243, 4885.804567817283, 4636.4899861015265, 4686.601638860701, 4776.880577985544, 4871.4397844248015, 4884.511548845123, 4750.952490475085, 4791.664583479158, 4796.568308852203, 4808.422989241296, 4817.325574419584, 4781.497942716034, 4784.712917224978, 4799.496052914464, 4799.928001079987, 4802.111609352246, 4206.116715489751, 4210.621044106045, 4220.261454245495, 4223.97888010561, 4229.238737027334, 6072.423119803611, 6076.270847498328, 6081.11823785553, 6085.148079268906, 6097.268327800648, 5384.703841288728, 5584.6090773645865, 5589.357223919261, 5597.888042239132, 5612.550995920357, 6619.5035372347265, 6639.93360066398, 6647.036179753909, 6650.667466626698, 6653.500987425914, 4592.908141837178, 4600.35595016698, 4602.355670206174, 4605.125026245037, 4609.03210325832, 6865.725370985155, 6933.514653974224, 6938.687759050855, 6944.305569443066, 6945.7221711132, 4687.156311863897, 4716.646251531149, 4718.598919091847, 4722.079194557097, 4722.504137065559, 4708.364370809897, 4771.880702982384, 4774.092922344813, 4777.092352453023, 4783.0, 5487.890242195133, 5523.530499907472, 5539.279893613804, 5562.110062389998, 5574.136008918624, 6622.304658010839, 6655.900161497581, 6669.599824010478, 6673.065770792093, 6685.097511835937, 1639.9344026238816, 1691.7969843618844, 1705.9573510662333, 1736.8436840684399, 1740.843324100837, 1155.9075273978062, 1176.0650283025016, 1183.7099910521806, 1184.8874356936078, 1190.9404529773476, 6442.291347951722, 6457.547971642034, 6463.64449955257, 6464.515161362822, 6466.80364132637, 6812.352826481477, 6813.727450901908, 6814.080099186546, 6817.795466136024, 6839.350261725128, 6441.259255185713, 6443.710033048524, 6445.967770161119, 6452.77415290472, 6487.416132547999, 3661.7436779425184, 3682.576503702055, 3690.9815450922574, 3692.649198326155, 3693.076730817296, 6950.366663833995, 7118.359347658632, 7124.6081465518855, 7124.821879453055, 7128.394086502602, 6970.930290697028, 6989.196242432084, 7000.0, 7003.614801185881, 7004.334588214111, 7075.610841403669, 7081.468889833283, 7096.432285417154, 7096.467764917652, 7096.787096387116, 6820.874555698452, 6826.283240259701, 6826.692798824164, 6834.624095674786, 6843.110395648534, 6548.0, 6698.799036028927, 6728.899066513908, 6740.494462915203, 6744.460443164437, 7044.260352663102, 7076.221615622175, 7086.185088714864, 7091.184513780981, 7118.216996130525, 4878.9512104878495, 4882.6338024649, 4888.0, 4895.339129217653, 4895.559399654048, 6704.463642908653, 6752.426043786333, 6848.520603557703, 6849.589024658537, 6851.177858656993, 6696.59820410777, 6699.598024118569, 6736.326367363225, 6738.561993470409, 6758.0, 6727.966360168168, 6734.696938637675, 6751.3248675134055, 6754.425873800782, 6760.053592496956, 6629.46964242869, 6635.303293154342, 6635.303293154342, 6637.668116594247, 6646.2356828965285, 6561.704723287559, 6794.0, 6801.863962720817, 6830.658467076527, 6844.828879278058, 6584.7036883341325, 6634.0712300278965, 6634.635095069624, 6645.833854153685, 6647.302033286435], "value": 5043.988337275875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.779739470343, 817.9386546009051, 840.7982084299762, 908.0964440381821, 914.5427286356821, 13760.082905271754, 14227.075240109398, 14515.419383224686, 14600.70798584029, 14733.336999835006, 13812.447502099929, 13873.722525549483, 13928.30358482077, 14008.439662413492, 14024.088434251766, 882.7351794461651, 898.0, 903.9231665308457, 904.4256896870502, 905.1446383167876, 754.0687251244735, 887.5828360670474, 897.9865302020474, 901.5852707754408, 907.1110311894347, 934.1779234273863, 934.6635211323918, 936.3773090894547, 938.9014153513886, 940.952952352383, 790.3203245209115, 932.8227636748996, 934.0, 934.626149540186, 935.6351023100996, 685.1846302899534, 689.3864460630043, 689.5311188391892, 690.6063543780048, 691.1774987764544, 14467.493637722735, 14480.131192128401, 14574.41702331916, 14724.779128313085, 14732.70534589313, 13506.459741610324, 14275.35760890752, 14418.711625767426, 14433.0, 14653.194074325907, 11290.887091129065, 11360.602378916697, 11626.186166968231, 11662.183647144704, 11774.587889423829, 3821.407681809324, 3843.8846834595006, 3864.478295430137, 3892.5134358205223, 3912.3349030664854, 52925.941481170164, 53587.0, 54096.45903540993, 57169.0, 57306.713466432404, 11239.263315478207, 11405.315681059163, 11420.714482138013, 11622.825657615143, 12252.509899604094, 19973.600527989358, 20001.0, 20018.89990550038, 20070.39788806338, 20088.49778755543, 8439.451435656663, 8450.704225352083, 8526.190011948855, 8530.573471326408, 8702.086280940537, 4682.227432473604, 4751.073540659608, 4877.975610121926, 4894.290327902506, 4967.875803104879, 3604.675579197885, 3634.854605815791, 3652.543432070991, 3658.176910195185, 3660.615635358249, 668.6055227415848, 684.5789839248926, 685.5989246290976, 694.2779509310361, 694.6457306773481, 669.9548704021742, 698.5250029979561, 713.3294702979183, 784.486161564165, 810.0926961802701, 9724.222062235005, 10129.0, 10169.9491502542, 10182.694519164437, 10238.846417303746, 711.3242419701304, 754.8565772503207, 816.3387655998661, 816.4733746733442, 819.8975128108987, 4204.159168166379, 4428.623566996777, 4527.162474942146, 4641.094986477672, 4732.71603703772, 63886.0, 63982.48096354652, 64279.67860160669, 64293.678531607045, 65107.0, 54804.0, 57865.13202301969, 58780.7060964701, 58825.70587147037, 59049.70475147597, 50704.74647626812, 51153.23270150951, 51213.0, 52030.73984630052, 52526.737366312926, 8627.654893804429, 8681.0, 9056.501892395981, 9070.600298192445, 9290.16388525036, 38194.42708359321, 38764.0, 38818.0, 39227.41158882562, 40003.79998099991, 45617.54382456266, 48897.0, 49009.26486102783, 49887.75056124696, 50171.498285016685, 11565.768684626091, 11597.82603260935, 11631.0, 11693.415329233674, 11872.82190767122, 12317.75364492723, 12453.688657783629, 12831.743365132832, 12973.286469244282, 13360.465581377024, 11456.198066135625, 11717.238379505305, 11862.644120676394, 11916.404179790803, 12005.039596832406, 11932.880671193177, 12020.218685785396, 12025.759484810429, 12035.0, 12651.746965060463, 11530.654080377602, 11550.422478875855, 11557.075433965094, 11560.30638161713, 11798.705032374259, 9662.758431039, 9816.067473589997, 9946.850797237903, 9951.203903687832, 10371.325863818827, 9660.806783864424, 10057.195424365887, 10071.446070466194, 10072.949635251776, 10118.241131914989], "value": 6948.919106789847, "unit": "score"}], "name": "dromaeo_css", "value": 7495.041642137194, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 111.0, 112.0, 112.0, 111.0, 105.0, 110.0, 110.0, 109.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 156.0, 177.0, 134.0, 162.0, 152.0, 128.0, 197.0, 127.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 164.0, 162.0, 162.0, 161.0, 160.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 73.0, 182.0, 73.0, 75.0, 73.0, 76.0, 164.0, 74.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 149.0, 92.0, 92.0, 92.0, 141.0, 91.0, 93.0, 155.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 55.0, 54.0, 55.0, 56.0, 70.0, 53.0, 53.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 58.0, 58.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 74.0, 72.0, 75.0, 74.0, 73.0, 73.0, 74.0, 73.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 113.0, 114.0, 112.0, 115.0, 114.0, 127.0, 115.0], "value": 115.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 163.0, 160.0, 162.0, 162.0, 164.0, 157.0, 158.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1516.3999999999996, "alertThreshold": 2.0}]} 12:04:45 INFO - Return code: 0 12:04:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:04:45 ERROR - # TBPL SUCCESS # 12:04:45 INFO - Running post-action listener: _resource_record_post_action 12:04:45 INFO - Running post-run listener: _resource_record_post_run 12:04:46 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 470708224; Read time: 12; Write time: 573896 12:04:46 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 250228736; Read time: 0; Write time: 410320 12:04:46 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220209152; Read time: 12; Write time: 163548 12:04:46 INFO - Running post-run listener: _upload_blobber_files 12:04:46 INFO - Blob upload gear active. 12:04:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:04:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:04:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:04:46 INFO - (blobuploader) - INFO - Open directory for files ... 12:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:04:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:47 INFO - (blobuploader) - INFO - Done attempting. 12:04:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:04:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:04:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:48 INFO - (blobuploader) - INFO - Done attempting. 12:04:48 INFO - (blobuploader) - INFO - Iteration through files over. 12:04:48 INFO - Return code: 0 12:04:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:04:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:04:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c608a1c0832ae0b524cf28cdacbb8b5a017ca677a85e82b9fcb130c31dc1c16ac3863d735b360e5211bf4894b07b715c3c1dac1b89bbec1f9b7ebe9bf236fe30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9913b6cec92ff7c6959715ab00ef37d70db3d45e7ec627f9e3bc868201238e2efb79e65bd52067f8aefecab39d9b9dcfa6dfeaf4f0ff2315a283b8f6f4406082"} 12:04:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:04:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:04:48 INFO - Contents: 12:04:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c608a1c0832ae0b524cf28cdacbb8b5a017ca677a85e82b9fcb130c31dc1c16ac3863d735b360e5211bf4894b07b715c3c1dac1b89bbec1f9b7ebe9bf236fe30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9913b6cec92ff7c6959715ab00ef37d70db3d45e7ec627f9e3bc868201238e2efb79e65bd52067f8aefecab39d9b9dcfa6dfeaf4f0ff2315a283b8f6f4406082"} 12:04:48 INFO - Running post-run listener: copy_logs_to_upload_dir 12:04:48 INFO - Copying logs to upload dir... 12:04:48 INFO - mkdir: /builds/slave/test/build/upload/logs 12:04:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.524215 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-27 12:04:48.111596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 12:04:48.114854) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603 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/c608a1c0832ae0b524cf28cdacbb8b5a017ca677a85e82b9fcb130c31dc1c16ac3863d735b360e5211bf4894b07b715c3c1dac1b89bbec1f9b7ebe9bf236fe30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9913b6cec92ff7c6959715ab00ef37d70db3d45e7ec627f9e3bc868201238e2efb79e65bd52067f8aefecab39d9b9dcfa6dfeaf4f0ff2315a283b8f6f4406082"} build_url:https://queue.taskcluster.net/v1/task/MsudjZ2BTyy_hw_1FKviIQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/MsudjZ2BTyy_hw_1FKviIQ/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/c608a1c0832ae0b524cf28cdacbb8b5a017ca677a85e82b9fcb130c31dc1c16ac3863d735b360e5211bf4894b07b715c3c1dac1b89bbec1f9b7ebe9bf236fe30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9913b6cec92ff7c6959715ab00ef37d70db3d45e7ec627f9e3bc868201238e2efb79e65bd52067f8aefecab39d9b9dcfa6dfeaf4f0ff2315a283b8f6f4406082"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 12:04:48.141883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 12:04:48.142260) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467052966.329669-1494449603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 12:04:48.225296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 12:04:48.225603) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 12:04:48.225887) ========= ========= Total master_lag: 0.19 =========