builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1462953573.04 results: success (0) buildid: 20160510223109 builduid: 052ff848384e43aa9a45b3c1382e3552 revision: d6c7ebc1417b9d27f75b57834a672ac8b9008163 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.040922) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.041297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.041577) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.066381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.066743) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 00:59:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-05-11 00:59:33 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.206928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.207237) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018016 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.259205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.262593) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d6c7ebc1417b9d27f75b57834a672ac8b9008163 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d6c7ebc1417b9d27f75b57834a672ac8b9008163 --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=934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 00:59:33,394 truncating revision to first 12 chars 2016-05-11 00:59:33,395 Setting DEBUG logging. 2016-05-11 00:59:33,395 attempt 1/10 2016-05-11 00:59:33,395 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d6c7ebc1417b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 00:59:33,705 unpacking tar archive at: mozilla-inbound-d6c7ebc1417b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.876073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.876388) ========= script_repo_revision: d6c7ebc1417b9d27f75b57834a672ac8b9008163 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.876803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.877126) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 00:59:33.884909) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-11 00:59:33.885248) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:59:34 INFO - MultiFileLogger online at 20160511 00:59:34 in /builds/slave/test 00:59:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:59:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:59:34 INFO - {'append_to_log': False, 00:59:34 INFO - 'base_work_dir': '/builds/slave/test', 00:59:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:59:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:59:34 INFO - 'branch': 'Mozilla-Inbound', 00:59:34 INFO - 'buildbot_json_path': 'buildprops.json', 00:59:34 INFO - 'config_files': ('talos/linux_config.py',), 00:59:34 INFO - 'default_actions': ('clobber', 00:59:34 INFO - 'read-buildbot-config', 00:59:34 INFO - 'download-and-extract', 00:59:34 INFO - 'populate-webroot', 00:59:34 INFO - 'create-virtualenv', 00:59:34 INFO - 'install', 00:59:34 INFO - 'run-tests'), 00:59:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:59:34 INFO - 'download_minidump_stackwalk': True, 00:59:34 INFO - 'download_symbols': 'ondemand', 00:59:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:59:34 INFO - 'tooltool.py': '/tools/tooltool.py', 00:59:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:59:34 INFO - '/tools/misc-python/virtualenv.py')}, 00:59:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:59:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:59:34 INFO - 'installer_path': 'installer.exe', 00:59:34 INFO - 'log_level': 'info', 00:59:34 INFO - 'log_name': 'talos', 00:59:34 INFO - 'log_to_console': True, 00:59:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:59:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:59:34 INFO - 'opt_config_files': (), 00:59:34 INFO - 'pip_index': False, 00:59:34 INFO - 'sps_profile': False, 00:59:34 INFO - 'sps_profile_interval': 0, 00:59:34 INFO - 'suite': 'dromaeojs', 00:59:34 INFO - 'system_bits': '32', 00:59:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:59:34 INFO - 'title': 'talos-linux64-ix-057', 00:59:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:59:34 INFO - 'use_talos_json': True, 00:59:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:59:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:59:34 INFO - 'work_dir': 'build'} 00:59:34 INFO - ##### 00:59:34 INFO - ##### Running clobber step. 00:59:34 INFO - ##### 00:59:34 INFO - Running pre-action listener: _resource_record_pre_action 00:59:34 INFO - Running main action method: clobber 00:59:34 INFO - rmtree: /builds/slave/test/build 00:59:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:59:34 INFO - Running post-action listener: _resource_record_post_action 00:59:34 INFO - ##### 00:59:34 INFO - ##### Finished clobber step (success) 00:59:34 INFO - ##### 00:59:34 INFO - ##### 00:59:34 INFO - ##### Running read-buildbot-config step. 00:59:34 INFO - ##### 00:59:34 INFO - Running pre-action listener: _resource_record_pre_action 00:59:34 INFO - Running main action method: read_buildbot_config 00:59:34 INFO - Using buildbot properties: 00:59:34 INFO - { 00:59:34 INFO - "project": "", 00:59:34 INFO - "product": "firefox", 00:59:34 INFO - "script_repo_revision": "production", 00:59:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:59:34 INFO - "repository": "", 00:59:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 00:59:34 INFO - "buildid": "20160510223109", 00:59:34 INFO - "pgo_build": "True", 00:59:34 INFO - "basedir": "/builds/slave/test", 00:59:34 INFO - "buildnumber": 971, 00:59:34 INFO - "slavename": "talos-linux64-ix-057", 00:59:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:59:34 INFO - "platform": "ubuntu64_hw", 00:59:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:59:34 INFO - "branch": "mozilla-inbound", 00:59:34 INFO - "repo_path": "integration/mozilla-inbound", 00:59:34 INFO - "revision": "d6c7ebc1417b9d27f75b57834a672ac8b9008163", 00:59:34 INFO - "stage_platform": "linux64-pgo", 00:59:34 INFO - "builduid": "052ff848384e43aa9a45b3c1382e3552", 00:59:34 INFO - "slavebuilddir": "test" 00:59:34 INFO - } 00:59:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 00:59:34 INFO - Running post-action listener: _resource_record_post_action 00:59:34 INFO - ##### 00:59:34 INFO - ##### Finished read-buildbot-config step (success) 00:59:34 INFO - ##### 00:59:34 INFO - ##### 00:59:34 INFO - ##### Running download-and-extract step. 00:59:34 INFO - ##### 00:59:34 INFO - Running pre-action listener: _resource_record_pre_action 00:59:34 INFO - Running main action method: download_and_extract 00:59:34 INFO - mkdir: /builds/slave/test/build/tests 00:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:34 INFO - https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:59:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:59:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:59:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:59:35 INFO - Downloaded 1361 bytes. 00:59:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:59:35 INFO - Using the following test package requirements: 00:59:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:59:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:59:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:59:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:35 INFO - u'jsshell-linux-x86_64.zip'], 00:59:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:59:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:59:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:59:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:59:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:59:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:59:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:35 INFO - https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:59:37 INFO - Downloaded 23903142 bytes. 00:59:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:59:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:59:38 INFO - Return code: 0 00:59:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:38 INFO - https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:59:42 INFO - Downloaded 23903142 bytes. 00:59:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:59:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:59:44 INFO - Return code: 0 00:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:44 INFO - https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:59:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:59:45 INFO - Downloaded 10840152 bytes. 00:59:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:59:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:59:46 INFO - Return code: 0 00:59: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')]} 00:59:46 INFO - https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:59:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:59:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:59:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:59:48 INFO - Downloaded 58342803 bytes. 00:59:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:59:48 INFO - mkdir: /builds/slave/test/properties 00:59:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:59:48 INFO - Writing to file /builds/slave/test/properties/build_url 00:59:48 INFO - Contents: 00:59:48 INFO - build_url:https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:59:48 INFO - Running post-action listener: _resource_record_post_action 00:59:48 INFO - Running post-action listener: set_extra_try_arguments 00:59:48 INFO - ##### 00:59:48 INFO - ##### Finished download-and-extract step (success) 00:59:48 INFO - ##### 00:59:48 INFO - ##### 00:59:48 INFO - ##### Running populate-webroot step. 00:59:48 INFO - ##### 00:59:48 INFO - Running pre-action listener: _resource_record_pre_action 00:59:48 INFO - Running main action method: populate_webroot 00:59:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:59:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:59:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:59:48 INFO - '--tppagecycles', 00:59:48 INFO - '7'], 00:59:48 INFO - 'tests': ['tsvgm']}}, 00:59:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:59:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:59:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:59:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:59:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:59:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:59:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:48 INFO - 'talos_options': ['--disable-e10s'], 00:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:59:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:59:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:48 INFO - 'talos_options': ['--disable-e10s'], 00:59:48 INFO - 'tests': ['damp', 'tps']}, 00:59:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:48 INFO - 'tests': ['damp', 'tps']}, 00:59:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:59:48 INFO - 'tests': ['dromaeo_dom']}, 00:59:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:59:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:59:48 INFO - 'tests': ['a11yr', 00:59:48 INFO - 'ts_paint', 00:59:48 INFO - 'tpaint', 00:59:48 INFO - 'sessionrestore', 00:59:48 INFO - 'sessionrestore_no_auto_restore', 00:59:48 INFO - 'tabpaint']}, 00:59:48 INFO - 'other-e10s': {'tests': ['a11yr', 00:59:48 INFO - 'ts_paint', 00:59:48 INFO - 'tpaint', 00:59:48 INFO - 'sessionrestore', 00:59:48 INFO - 'sessionrestore_no_auto_restore', 00:59:48 INFO - 'tabpaint']}, 00:59:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:59:48 INFO - 'ts_paint', 00:59:48 INFO - 'tpaint', 00:59:48 INFO - 'sessionrestore', 00:59:48 INFO - 'sessionrestore_no_auto_restore', 00:59:48 INFO - 'tabpaint']}, 00:59:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:59:48 INFO - 'ts_paint', 00:59:48 INFO - 'tpaint', 00:59:48 INFO - 'sessionrestore', 00:59:48 INFO - 'sessionrestore_no_auto_restore', 00:59:48 INFO - 'tabpaint']}, 00:59:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:59:48 INFO - 'tests': ['a11yr', 00:59:48 INFO - 'ts_paint', 00:59:48 INFO - 'tpaint', 00:59:48 INFO - 'sessionrestore', 00:59:48 INFO - 'sessionrestore_no_auto_restore', 00:59:48 INFO - 'tabpaint']}, 00:59:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:59:48 INFO - 'tests': ['a11yr', 00:59:48 INFO - 'ts_paint', 00:59:48 INFO - 'tpaint', 00:59:48 INFO - 'sessionrestore', 00:59:48 INFO - 'sessionrestore_no_auto_restore', 00:59:48 INFO - 'tabpaint']}, 00:59:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:59:48 INFO - 'tests': ['tsvgx', 00:59:48 INFO - 'tsvgr_opacity', 00:59:48 INFO - 'tart', 00:59:48 INFO - 'tscrollx', 00:59:48 INFO - 'cart']}, 00:59:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:59:48 INFO - 'tsvgr_opacity', 00:59:48 INFO - 'tart', 00:59:48 INFO - 'tscrollx', 00:59:48 INFO - 'cart']}, 00:59:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:48 INFO - 'talos_options': ['--disable-e10s'], 00:59:48 INFO - 'tests': ['tp5o']}, 00:59:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:48 INFO - 'tests': ['tp5o']}, 00:59:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:48 INFO - 'talos_options': ['--disable-e10s', 00:59:48 INFO - '--xperf_path', 00:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:59:48 INFO - 'tests': ['tp5n']}, 00:59:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:48 INFO - 'talos_options': ['--xperf_path', 00:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:59:48 INFO - 'tests': ['tp5n']}}, 00:59:48 INFO - 'talos.zip': {'path': '', 00:59:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:59:48 INFO - Running post-action listener: _resource_record_post_action 00:59:48 INFO - ##### 00:59:48 INFO - ##### Finished populate-webroot step (success) 00:59:48 INFO - ##### 00:59:48 INFO - ##### 00:59:48 INFO - ##### Running create-virtualenv step. 00:59:48 INFO - ##### 00:59:48 INFO - Running pre-action listener: _resource_record_pre_action 00:59:48 INFO - Running main action method: create_virtualenv 00:59:48 INFO - Creating virtualenv /builds/slave/test/build/venv 00:59:48 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 00:59:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:59:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:59:49 INFO - Using real prefix '/usr' 00:59:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:59:49 INFO - Installing distribute.............................................................................................................................................................................................done. 00:59:51 INFO - Installing pip.................done. 00:59:51 INFO - Return code: 0 00:59:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:59:51 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')]} 00:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:51 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')]} 00:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:51 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 0x7fc5cedf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25339c0>, '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 0x25348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', '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 00:59:51 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 00:59:51 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 00:59:51 INFO - Using env: {'DISPLAY': ':0', 00:59:51 INFO - 'HOME': '/home/cltbld', 00:59:51 INFO - 'LANG': 'en_US.UTF-8', 00:59:51 INFO - 'LANGUAGE': 'en_US:en', 00:59:51 INFO - 'LOGNAME': 'cltbld', 00:59:51 INFO - 'MAIL': '/var/mail/cltbld', 00:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:51 INFO - 'MOZ_NO_REMOTE': '1', 00:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:51 INFO - 'NO_EM_RESTART': '1', 00:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:51 INFO - 'PWD': '/builds/slave/test', 00:59:51 INFO - 'SHELL': '/bin/bash', 00:59:51 INFO - 'SHLVL': '1', 00:59:51 INFO - 'TERM': 'linux', 00:59:51 INFO - 'TMOUT': '86400', 00:59:51 INFO - 'USER': 'cltbld', 00:59:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', 00:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:51 INFO - '_': '/tools/buildbot/bin/python'} 00:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:51 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 00:59:51 INFO - Cleaning up... 00:59:51 INFO - Return code: 0 00:59:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:59:51 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')]} 00:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:51 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')]} 00:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:51 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 0x7fc5cedf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25339c0>, '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 0x25348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', '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 00:59:51 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 00:59:51 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 00:59:51 INFO - Using env: {'DISPLAY': ':0', 00:59:51 INFO - 'HOME': '/home/cltbld', 00:59:51 INFO - 'LANG': 'en_US.UTF-8', 00:59:51 INFO - 'LANGUAGE': 'en_US:en', 00:59:51 INFO - 'LOGNAME': 'cltbld', 00:59:51 INFO - 'MAIL': '/var/mail/cltbld', 00:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:51 INFO - 'MOZ_NO_REMOTE': '1', 00:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:51 INFO - 'NO_EM_RESTART': '1', 00:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:51 INFO - 'PWD': '/builds/slave/test', 00:59:51 INFO - 'SHELL': '/bin/bash', 00:59:51 INFO - 'SHLVL': '1', 00:59:51 INFO - 'TERM': 'linux', 00:59:51 INFO - 'TMOUT': '86400', 00:59:51 INFO - 'USER': 'cltbld', 00:59:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', 00:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:51 INFO - '_': '/tools/buildbot/bin/python'} 00:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:51 INFO - Downloading/unpacking psutil>=0.7.1 00:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:59:53 INFO - Installing collected packages: psutil 00:59:53 INFO - Running setup.py install for psutil 00:59:54 INFO - building 'psutil._psutil_linux' extension 00:59:54 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 00:59:54 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 00:59:54 INFO - building 'psutil._psutil_posix' extension 00:59:54 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 00:59:54 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 00:59:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:59:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:59:54 INFO - Successfully installed psutil 00:59:54 INFO - Cleaning up... 00:59:54 INFO - Return code: 0 00:59:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5cedf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25339c0>, '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 0x25348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', '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 00:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:59:54 INFO - Using env: {'DISPLAY': ':0', 00:59:54 INFO - 'HOME': '/home/cltbld', 00:59:54 INFO - 'LANG': 'en_US.UTF-8', 00:59:54 INFO - 'LANGUAGE': 'en_US:en', 00:59:54 INFO - 'LOGNAME': 'cltbld', 00:59:54 INFO - 'MAIL': '/var/mail/cltbld', 00:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:54 INFO - 'MOZ_NO_REMOTE': '1', 00:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:54 INFO - 'NO_EM_RESTART': '1', 00:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:54 INFO - 'PWD': '/builds/slave/test', 00:59:54 INFO - 'SHELL': '/bin/bash', 00:59:54 INFO - 'SHLVL': '1', 00:59:54 INFO - 'TERM': 'linux', 00:59:54 INFO - 'TMOUT': '86400', 00:59:54 INFO - 'USER': 'cltbld', 00:59:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', 00:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:54 INFO - '_': '/tools/buildbot/bin/python'} 00:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:59:54 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 00:59:54 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 00:59:54 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 00:59:54 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 00:59:54 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 00:59:54 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 00:59:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:59:56 INFO - Installing collected packages: mozsystemmonitor 00:59:56 INFO - Running setup.py install for mozsystemmonitor 00:59:56 INFO - Successfully installed mozsystemmonitor 00:59:56 INFO - Cleaning up... 00:59:56 INFO - Return code: 0 00:59:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:59: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')]} 00:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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')]} 00:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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', '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 0x7fc5cedf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25339c0>, '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 0x25348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', '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 00:59: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:59: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 blobuploader==1.2.4 00:59:56 INFO - Using env: {'DISPLAY': ':0', 00:59:56 INFO - 'HOME': '/home/cltbld', 00:59:56 INFO - 'LANG': 'en_US.UTF-8', 00:59:56 INFO - 'LANGUAGE': 'en_US:en', 00:59:56 INFO - 'LOGNAME': 'cltbld', 00:59:56 INFO - 'MAIL': '/var/mail/cltbld', 00:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:56 INFO - 'MOZ_NO_REMOTE': '1', 00:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:56 INFO - 'NO_EM_RESTART': '1', 00:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:56 INFO - 'PWD': '/builds/slave/test', 00:59:56 INFO - 'SHELL': '/bin/bash', 00:59:56 INFO - 'SHLVL': '1', 00:59:56 INFO - 'TERM': 'linux', 00:59:56 INFO - 'TMOUT': '86400', 00:59:56 INFO - 'USER': 'cltbld', 00:59:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', 00:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:56 INFO - '_': '/tools/buildbot/bin/python'} 00:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:57 INFO - Downloading/unpacking blobuploader==1.2.4 00:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:58 INFO - Downloading blobuploader-1.2.4.tar.gz 00:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:59:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:59:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:59:59 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 00:59:59 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 00:59:59 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 00:59:59 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 00:59:59 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 00:59:59 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 00:59:59 INFO - Downloading docopt-0.6.1.tar.gz 00:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:59:59 INFO - Installing collected packages: blobuploader, requests, docopt 00:59:59 INFO - Running setup.py install for blobuploader 00:59:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:59:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:59:59 INFO - Running setup.py install for requests 01:00:00 INFO - Running setup.py install for docopt 01:00:00 INFO - Successfully installed blobuploader requests docopt 01:00:00 INFO - Cleaning up... 01:00:00 INFO - Return code: 0 01:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:00 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 0x7fc5cedf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25339c0>, '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 0x25348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', '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 01:00:00 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 01:00:00 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 01:00:00 INFO - Using env: {'DISPLAY': ':0', 01:00:00 INFO - 'HOME': '/home/cltbld', 01:00:00 INFO - 'LANG': 'en_US.UTF-8', 01:00:00 INFO - 'LANGUAGE': 'en_US:en', 01:00:00 INFO - 'LOGNAME': 'cltbld', 01:00:00 INFO - 'MAIL': '/var/mail/cltbld', 01:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:00 INFO - 'MOZ_NO_REMOTE': '1', 01:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:00 INFO - 'NO_EM_RESTART': '1', 01:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:00 INFO - 'PWD': '/builds/slave/test', 01:00:00 INFO - 'SHELL': '/bin/bash', 01:00:00 INFO - 'SHLVL': '1', 01:00:00 INFO - 'TERM': 'linux', 01:00:00 INFO - 'TMOUT': '86400', 01:00:00 INFO - 'USER': 'cltbld', 01:00:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', 01:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:00 INFO - '_': '/tools/buildbot/bin/python'} 01:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:00 INFO - Running setup.py (path:/tmp/pip-zapxh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:00 INFO - Running setup.py (path:/tmp/pip-zXXQzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:00 INFO - Running setup.py (path:/tmp/pip-kY819Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:00 INFO - Running setup.py (path:/tmp/pip-kvT3db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:00 INFO - Running setup.py (path:/tmp/pip-CIIWl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:00 INFO - Running setup.py (path:/tmp/pip-EMfpGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:00 INFO - Running setup.py (path:/tmp/pip-piGdRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:00 INFO - Running setup.py (path:/tmp/pip-wr19su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:01 INFO - Running setup.py (path:/tmp/pip-i545lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:01 INFO - Running setup.py (path:/tmp/pip-KKIndy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:01 INFO - Running setup.py (path:/tmp/pip-AmMDzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:01 INFO - Running setup.py (path:/tmp/pip-gDAGnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:01 INFO - Running setup.py (path:/tmp/pip-slVKr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:01 INFO - Running setup.py (path:/tmp/pip-na63_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:01 INFO - Running setup.py (path:/tmp/pip-TK5GMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:01 INFO - Running setup.py (path:/tmp/pip-GLny9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:01 INFO - Running setup.py (path:/tmp/pip-VHPtJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:00:01 INFO - Running setup.py install for manifestparser 01:00:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:00:01 INFO - Running setup.py install for mozcrash 01:00:01 INFO - Running setup.py install for mozdebug 01:00:01 INFO - Running setup.py install for mozdevice 01:00:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:00:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:00:02 INFO - Running setup.py install for mozfile 01:00:02 INFO - Running setup.py install for mozhttpd 01:00:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:00:02 INFO - Running setup.py install for mozinfo 01:00:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:00:02 INFO - Running setup.py install for mozInstall 01:00:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:00:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:00:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:00:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:00:02 INFO - Running setup.py install for mozleak 01:00:02 INFO - Running setup.py install for mozlog 01:00:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:00:02 INFO - Running setup.py install for moznetwork 01:00:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:00:02 INFO - Running setup.py install for mozprocess 01:00:02 INFO - Running setup.py install for mozprofile 01:00:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:00:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:00:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:00:03 INFO - Running setup.py install for mozrunner 01:00:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:00:03 INFO - Running setup.py install for mozscreenshot 01:00:03 INFO - Running setup.py install for moztest 01:00:03 INFO - Running setup.py install for mozversion 01:00:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:00:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:00:03 INFO - Cleaning up... 01:00:03 INFO - Return code: 0 01:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:03 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 0x7fc5cedf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25339c0>, '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 0x25348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', '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 01:00:03 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 01:00:03 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 01:00:03 INFO - Using env: {'DISPLAY': ':0', 01:00:03 INFO - 'HOME': '/home/cltbld', 01:00:03 INFO - 'LANG': 'en_US.UTF-8', 01:00:03 INFO - 'LANGUAGE': 'en_US:en', 01:00:03 INFO - 'LOGNAME': 'cltbld', 01:00:03 INFO - 'MAIL': '/var/mail/cltbld', 01:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:03 INFO - 'MOZ_NO_REMOTE': '1', 01:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:03 INFO - 'NO_EM_RESTART': '1', 01:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:03 INFO - 'PWD': '/builds/slave/test', 01:00:03 INFO - 'SHELL': '/bin/bash', 01:00:03 INFO - 'SHLVL': '1', 01:00:03 INFO - 'TERM': 'linux', 01:00:03 INFO - 'TMOUT': '86400', 01:00:03 INFO - 'USER': 'cltbld', 01:00:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', 01:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:03 INFO - '_': '/tools/buildbot/bin/python'} 01:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:03 INFO - Running setup.py (path:/tmp/pip-LOrH8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:03 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)) 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:03 INFO - Running setup.py (path:/tmp/pip-Zb9dPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:03 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)) 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:03 INFO - Running setup.py (path:/tmp/pip-x9IH8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:03 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)) 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:03 INFO - Running setup.py (path:/tmp/pip-BUIEdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:03 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)) 01:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:04 INFO - Running setup.py (path:/tmp/pip-6NMWkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:04 INFO - Running setup.py (path:/tmp/pip-vH2L5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:04 INFO - Running setup.py (path:/tmp/pip-TAfNlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:04 INFO - Running setup.py (path:/tmp/pip-9fzKOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:04 INFO - Running setup.py (path:/tmp/pip-TYY1NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:04 INFO - Running setup.py (path:/tmp/pip-9fAqlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:04 INFO - Running setup.py (path:/tmp/pip-IHnlwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:04 INFO - Running setup.py (path:/tmp/pip-fQ659E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:04 INFO - Running setup.py (path:/tmp/pip-Tc8PUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:04 INFO - Running setup.py (path:/tmp/pip-QH99l8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:04 INFO - Running setup.py (path:/tmp/pip-kRgA5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:04 INFO - Running setup.py (path:/tmp/pip-eXgqhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:04 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)) 01:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:04 INFO - Running setup.py (path:/tmp/pip-n06zSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:04 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)) 01:00:04 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)) 01:00:04 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)) 01:00:04 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)) 01:00:04 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)) 01:00:04 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)) 01:00:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:00:04 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 01:00:04 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 01:00:04 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 01:00:04 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 01:00:04 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 01:00:04 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 01:00:06 INFO - Downloading blessings-1.6.tar.gz 01:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:00:06 INFO - Installing collected packages: blessings 01:00:06 INFO - Running setup.py install for blessings 01:00:07 INFO - Successfully installed blessings 01:00:07 INFO - Cleaning up... 01:00:07 INFO - Return code: 0 01:00:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:07 INFO - Reading from file tmpfile_stdout 01:00:07 INFO - Current package versions: 01:00:07 INFO - argparse == 1.2.1 01:00:07 INFO - blessings == 1.6 01:00:07 INFO - blobuploader == 1.2.4 01:00:07 INFO - docopt == 0.6.1 01:00:07 INFO - manifestparser == 1.1 01:00:07 INFO - mozInstall == 1.12 01:00:07 INFO - mozcrash == 0.17 01:00:07 INFO - mozdebug == 0.1 01:00:07 INFO - mozdevice == 0.48 01:00:07 INFO - mozfile == 1.2 01:00:07 INFO - mozhttpd == 0.7 01:00:07 INFO - mozinfo == 0.9 01:00:07 INFO - mozleak == 0.1 01:00:07 INFO - mozlog == 3.1 01:00:07 INFO - moznetwork == 0.27 01:00:07 INFO - mozprocess == 0.22 01:00:07 INFO - mozprofile == 0.28 01:00:07 INFO - mozrunner == 6.11 01:00:07 INFO - mozscreenshot == 0.1 01:00:07 INFO - mozsystemmonitor == 0.0 01:00:07 INFO - moztest == 0.7 01:00:07 INFO - mozversion == 1.4 01:00:07 INFO - psutil == 3.1.1 01:00:07 INFO - requests == 1.2.3 01:00:07 INFO - wsgiref == 0.1.2 01:00:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:07 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 0x7fc5cedf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25339c0>, '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 0x25348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', '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 01:00:07 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 01:00:07 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 01:00:07 INFO - Using env: {'DISPLAY': ':0', 01:00:07 INFO - 'HOME': '/home/cltbld', 01:00:07 INFO - 'LANG': 'en_US.UTF-8', 01:00:07 INFO - 'LANGUAGE': 'en_US:en', 01:00:07 INFO - 'LOGNAME': 'cltbld', 01:00:07 INFO - 'MAIL': '/var/mail/cltbld', 01:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:07 INFO - 'MOZ_NO_REMOTE': '1', 01:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:07 INFO - 'NO_EM_RESTART': '1', 01:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:07 INFO - 'PWD': '/builds/slave/test', 01:00:07 INFO - 'SHELL': '/bin/bash', 01:00:07 INFO - 'SHLVL': '1', 01:00:07 INFO - 'TERM': 'linux', 01:00:07 INFO - 'TMOUT': '86400', 01:00:07 INFO - 'USER': 'cltbld', 01:00:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', 01:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:07 INFO - '_': '/tools/buildbot/bin/python'} 01:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 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)) 01:00:07 INFO - Cleaning up... 01:00:07 INFO - Return code: 0 01:00:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:07 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 0x7fc5cedf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25339c0>, '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 0x25348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', '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 01:00:07 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 01:00:07 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 01:00:07 INFO - Using env: {'DISPLAY': ':0', 01:00:07 INFO - 'HOME': '/home/cltbld', 01:00:07 INFO - 'LANG': 'en_US.UTF-8', 01:00:07 INFO - 'LANGUAGE': 'en_US:en', 01:00:07 INFO - 'LOGNAME': 'cltbld', 01:00:07 INFO - 'MAIL': '/var/mail/cltbld', 01:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:07 INFO - 'MOZ_NO_REMOTE': '1', 01:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:07 INFO - 'NO_EM_RESTART': '1', 01:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:07 INFO - 'PWD': '/builds/slave/test', 01:00:07 INFO - 'SHELL': '/bin/bash', 01:00:07 INFO - 'SHLVL': '1', 01:00:07 INFO - 'TERM': 'linux', 01:00:07 INFO - 'TMOUT': '86400', 01:00:07 INFO - 'USER': 'cltbld', 01:00:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', 01:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:07 INFO - '_': '/tools/buildbot/bin/python'} 01:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:07 INFO - Downloading/unpacking jsonschema 01:00:07 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 01:00:07 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 01:00:07 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 01:00:07 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 01:00:07 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 01:00:07 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 01:00:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:00:09 INFO - Downloading/unpacking functools32 (from jsonschema) 01:00:09 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 01:00:09 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 01:00:09 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 01:00:09 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 01:00:09 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 01:00:09 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 01:00:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:00:09 INFO - warning: no files found matching '*.txt' 01:00:09 INFO - no previously-included directories found matching 'build' 01:00:09 INFO - no previously-included directories found matching 'dist' 01:00:09 INFO - no previously-included directories found matching '.git*' 01:00:09 INFO - Installing collected packages: jsonschema, functools32 01:00:09 INFO - Running setup.py install for functools32 01:00:10 INFO - warning: no files found matching '*.txt' 01:00:10 INFO - no previously-included directories found matching 'build' 01:00:10 INFO - no previously-included directories found matching 'dist' 01:00:10 INFO - no previously-included directories found matching '.git*' 01:00:10 INFO - Successfully installed jsonschema functools32 01:00:10 INFO - Cleaning up... 01:00:10 INFO - Return code: 0 01:00:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:00:10 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')]} 01:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:10 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')]} 01:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:10 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 0x7fc5cedf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25339c0>, '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 0x25348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', '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 01:00:10 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 01:00:10 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 01:00:10 INFO - Using env: {'DISPLAY': ':0', 01:00:10 INFO - 'HOME': '/home/cltbld', 01:00:10 INFO - 'LANG': 'en_US.UTF-8', 01:00:10 INFO - 'LANGUAGE': 'en_US:en', 01:00:10 INFO - 'LOGNAME': 'cltbld', 01:00:10 INFO - 'MAIL': '/var/mail/cltbld', 01:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:10 INFO - 'MOZ_NO_REMOTE': '1', 01:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:10 INFO - 'NO_EM_RESTART': '1', 01:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:10 INFO - 'PWD': '/builds/slave/test', 01:00:10 INFO - 'SHELL': '/bin/bash', 01:00:10 INFO - 'SHLVL': '1', 01:00:10 INFO - 'TERM': 'linux', 01:00:10 INFO - 'TMOUT': '86400', 01:00:10 INFO - 'USER': 'cltbld', 01:00:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', 01:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:10 INFO - '_': '/tools/buildbot/bin/python'} 01:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:10 INFO - Downloading/unpacking flake8 01:00:10 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 01:00:10 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 01:00:10 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 01:00:10 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 01:00:10 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 01:00:10 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 01:00:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:00:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:00:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:00:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:00:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:00:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:00:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:00:12 INFO - no previously-included directories found matching 'docs/_build' 01:00:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:00:12 INFO - Running setup.py install for pep8 01:00:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:00:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:00:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:00:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:00:13 INFO - no previously-included directories found matching 'docs/_build' 01:00:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:00:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:00:13 INFO - Cleaning up... 01:00:13 INFO - Return code: 0 01:00:13 INFO - Running post-action listener: _resource_record_post_action 01:00:13 INFO - Running post-action listener: _start_resource_monitoring 01:00:13 INFO - Starting resource monitoring. 01:00:13 INFO - ##### 01:00:13 INFO - ##### Finished create-virtualenv step (success) 01:00:13 INFO - ##### 01:00:13 INFO - ##### 01:00:13 INFO - ##### Running install step. 01:00:13 INFO - ##### 01:00:13 INFO - Running pre-action listener: _resource_record_pre_action 01:00:13 INFO - Running main action method: install 01:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:13 INFO - Reading from file tmpfile_stdout 01:00:13 INFO - Detecting whether we're running mozinstall >=1.0... 01:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:00:13 INFO - Reading from file tmpfile_stdout 01:00:13 INFO - Output received: 01:00:13 INFO - Usage: mozinstall [options] installer 01:00:13 INFO - Options: 01:00:13 INFO - -h, --help show this help message and exit 01:00:13 INFO - -d DEST, --destination=DEST 01:00:13 INFO - Directory to install application into. [default: 01:00:13 INFO - "/builds/slave/test"] 01:00:13 INFO - --app=APP Application being installed. [default: firefox] 01:00:13 INFO - mkdir: /builds/slave/test/build/application 01:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:00:30 INFO - Reading from file tmpfile_stdout 01:00:30 INFO - Output received: 01:00:30 INFO - /builds/slave/test/build/application/firefox/firefox 01:00:30 INFO - Running post-action listener: _resource_record_post_action 01:00:30 INFO - ##### 01:00:30 INFO - ##### Finished install step (success) 01:00:30 INFO - ##### 01:00:30 INFO - ##### 01:00:30 INFO - ##### Running run-tests step. 01:00:30 INFO - ##### 01:00:30 INFO - Running pre-action listener: _resource_record_pre_action 01:00:30 INFO - Running main action method: run_tests 01:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:00:30 INFO - Python 2.7.3 01:00:30 INFO - Return code: 0 01:00:30 INFO - grabbing minidump binary from tooltool 01:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25339c0>, '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 0x25348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:00:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:00:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:00:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:00:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:00:30 INFO - Return code: 0 01:00:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:00:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:00:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:00:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:00:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:00:31 INFO - Return code: 0 01:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 01:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 01:00:31 INFO - Using env: {'DISPLAY': ':0', 01:00:31 INFO - 'HOME': '/home/cltbld', 01:00:31 INFO - 'LANG': 'en_US.UTF-8', 01:00:31 INFO - 'LANGUAGE': 'en_US:en', 01:00:31 INFO - 'LOGNAME': 'cltbld', 01:00:31 INFO - 'MAIL': '/var/mail/cltbld', 01:00:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:00:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:31 INFO - 'MOZ_NO_REMOTE': '1', 01:00:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:31 INFO - 'NO_EM_RESTART': '1', 01:00:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:31 INFO - 'PWD': '/builds/slave/test', 01:00:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:00:31 INFO - 'SHELL': '/bin/bash', 01:00:31 INFO - 'SHLVL': '1', 01:00:31 INFO - 'TERM': 'linux', 01:00:31 INFO - 'TMOUT': '86400', 01:00:31 INFO - 'USER': 'cltbld', 01:00:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622', 01:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:31 INFO - '_': '/tools/buildbot/bin/python'} 01:00:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 01:00:31 INFO - mozversion application_buildid: 20160510223109 01:00:31 INFO - mozversion application_changeset: d6c7ebc1417b9d27f75b57834a672ac8b9008163 01:00:31 INFO - mozversion application_display_name: Nightly 01:00:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:00:31 INFO - mozversion application_name: Firefox 01:00:31 INFO - mozversion application_remotingname: firefox 01:00:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:00:31 INFO - mozversion application_vendor: Mozilla 01:00:31 INFO - mozversion application_version: 49.0a1 01:00:31 INFO - mozversion platform_buildid: 20160510223109 01:00:31 INFO - mozversion platform_changeset: d6c7ebc1417b9d27f75b57834a672ac8b9008163 01:00:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:00:31 INFO - mozversion platform_version: 49.0a1 01:00:31 INFO - using testdate: 1462953631 01:00:31 INFO - actual date: 1462953631 01:00:31 INFO - starting webserver on 'localhost:58568' 01:00:31 INFO - SUITE-START | Running 2 tests 01:00:31 INFO - TEST-START | dromaeo_css 01:00:31 INFO - operating with platform_type : linux_ 01:00:31 INFO - Initialising browser for dromaeo_css test... 01:00:31 INFO - TEST-INFO | started process 26191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBdxqIE/profile http://localhost:58568/getInfo.html) 01:00:35 INFO - PROCESS | 26191 | __metrics Screen width/height:1600/1200 01:00:35 INFO - PROCESS | 26191 | colorDepth:24 01:00:35 INFO - PROCESS | 26191 | Browser inner width/height: 1024/697 01:00:35 INFO - PROCESS | 26191 | __metrics 01:00:36 ERROR - PROCESS | 26191 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:00:37 INFO - TEST-INFO | 26191: exit 0 01:00:37 INFO - Browser initialized. 01:00:37 INFO - Running cycle 1/1 for dromaeo_css test... 01:00:37 INFO - TEST-INFO | started process 26271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBdxqIE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:00:49 INFO - PROCESS | 26271 | RSS: Main: 152068096 01:00:49 INFO - PROCESS | 26271 | 01:01:40 INFO - PROCESS | 26271 | 1462953700159 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] 01:03:48 INFO - PROCESS | 26271 | Cycle 1(1): loaded http://localhost:58568/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58568/tests/dromaeo/cssquery-ext.html) 01:03:49 INFO - PROCESS | 26271 | RSS: Main: 253075456 01:03:49 INFO - PROCESS | 26271 | 01:06:51 INFO - PROCESS | 26271 | Cycle 1(1): loaded http://localhost:58568/tests/dromaeo/cssquery-ext.html (next: http://localhost:58568/tests/dromaeo/cssquery-jquery.html) 01:06:51 INFO - PROCESS | 26271 | RSS: Main: 231616512 01:06:51 INFO - PROCESS | 26271 | 01:09:53 INFO - PROCESS | 26271 | Cycle 1(1): loaded http://localhost:58568/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58568/tests/dromaeo/cssquery-mootools.html) 01:09:54 INFO - PROCESS | 26271 | RSS: Main: 242434048 01:09:54 INFO - PROCESS | 26271 | 01:12:56 INFO - PROCESS | 26271 | Cycle 1(1): loaded http://localhost:58568/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58568/tests/dromaeo/cssquery-prototype.html) 01:12:57 INFO - PROCESS | 26271 | RSS: Main: 239661056 01:12:57 INFO - PROCESS | 26271 | 01:15:59 INFO - PROCESS | 26271 | Cycle 1(1): loaded http://localhost:58568/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58568/tests/dromaeo/cssquery-yui.html) 01:16:00 INFO - PROCESS | 26271 | RSS: Main: 219652096 01:16:00 INFO - PROCESS | 26271 | 01:19:02 INFO - PROCESS | 26271 | Cycle 1(1): loaded http://localhost:58568/tests/dromaeo/cssquery-yui.html (next: http://localhost:58568/tests/dromaeo/cssquery-dojo.html) 01:19:03 INFO - PROCESS | 26271 | RSS: Main: 269246464 01:19:03 INFO - PROCESS | 26271 | 01:19:03 INFO - PROCESS | 26271 | __start_tp_report 01:19:03 INFO - PROCESS | 26271 | _x_x_mozilla_page_load 01:19:03 INFO - PROCESS | 26271 | _x_x_mozilla_page_load_details 01:19:03 INFO - PROCESS | 26271 | |i|pagename|runs| 01:19:03 INFO - PROCESS | 26271 | |0;dojo.html;3165.9683403165977;3176.364727054589;3224.645289018208;3230.8384580770985;3252.5609042779233;5216.191490318997;5280.313559237294;5343.358796944367;5444.673319600822;5465.125579907216;5357.8392648220615;5364;5368.194770784385;5418.485243901833;5435.374931882835;4810.855674329759;4816.63875209359;4994.700317980914;5003.224500202475;5032.798688052473;4946.109700253953;4962.826301079463;5020.548150666439;5020.6234532410035;5023.522765337287;4756.738379389132;4779.713217206961;4830.7101573905675;4845.878853028667;4852.587530059949;4842.080004799077;4850.781714822841;4851.078295123915;4863.610911127102;4897.853064408074;4742.075295317414;4794.35276237707;4804.855854324376;4828.348172996635;4862.5380588844;5297.231901374279;5356.598255130842;5362.168863826113;5399.1091469907415;5424.810131645373;5796.42035796417;5873.530117590582;5878.794242201545;5879.176915231871;5879.617824841372;5611.2144299798065;5750.079987202028;5900.734466948955;5923.970380148115;5928.377520360344;5387.380451248078;5486.835394938198;5497.092979658391;5510.972445137749;5511.696856672881;6043.456088951927;6048.788292409745;6048.848778780566;6049;6049.243844519435;5542.334919809568;5653.717314134276;5682.090865461589;5770.13447982806;5785.88428231433;5827.65034097947;5835.4748072673665;5838.065909454552;5841.415858414124;5876.471117599351;5781.075027995501;5816.331121920949;5824;5830.271216097988;5840.766369345263;5537.640053396597;5703.201551782754;5738.110592858114;5766.279215098113;5841.32824725162;4418.270985287391;4431.224535706238;4432.800523976429;4435.046465009974;4465.575770301816;3928.744631598937;3942.8817135485983;3957.56466788653;3986.123052928351;3991.102002049574;5281.683099014072;5325.121354976463;5434.157705555645;5479.3424789024775;5484.314460692413;5907.852303692442;5912.438318359749;5920.644761314335;5925.318588362394;5931.11033344993;5524.14375771756;5543.029969755276;5544.1960915667005;5544.362398324244;5546.722663866871;4894.730789806595;4980.90038199234;5020.573251273682;5025.874353141127;5054.039732450822;6054.788082417094;6058.545609079337;6064.06007068905;6064.151018857364;6066.363031881677;5632.85917852057;5838.095095260326;5839.445252700986;5850.882982340244;5851.824445266649;5936.3470018297085;5944.464998150014;5992.191054207626;6037.305709843248;6042.637441753509;5617.269754931833;5701.828945131652;5712.942870571241;5719.542436604978;5730.942690573041;5695.145728140812;5779.826605201851;5821.563382746226;5827.24245848037;5832;5637.887242255214;5697.914531281951;5703.458171473703;5706.343770466449;5745.8563535911935;5688.203651488712;5691.516221121251;5693.259876216065;5694.772209111755;5695;5336.573074153981;5410.83767486976;5419.810306639406;5584.581156413204;5596.608237423341;5609.859753506032;5635.774569017193;5638.9436105638415;5640.125780504029;5651.406602306699;5443.836684899459;5489.890202195854;5496.983058134258;5508.614396992172;5542.224088627676 01:19:03 INFO - PROCESS | 26271 | |1;ext.html;594.881023795241;612.9233845769279;643.7714611312987;647.3494138390917;651.4690527220315;33621.32757344855;35825;35848.99999999997;35899.64100358995;44285.77857110718;43048.78475607625;47318.76340618301;47380.76309618447;47438.52561474384;47444.76277618616;8858.512781797015;8895.555222238894;8899.68851090212;8905.599248033854;8915.1976322131;8674.132586741307;8789.472631642122;8796.736097917073;8808.603612837438;8874.822503549958;8709.129087091304;8783.297336213087;8783.73648790534;8814.471131732085;8815.559222038904;8772.429792063496;8826.86759698605;8922.821543569125;8931.062238464998;8942.284617230605;8842.381033327669;8845.071267516882;8858.73423797287;8909.821803563893;8926.73219803407;41605.375919361235;41991;42110;42147;42179.9455013624;3438.5529881115544;3546.131197856516;3550.680438760498;3561.679448849616;3576.8926932192076;32016;32541.83729081363;32886.342273154645;33278.50082248768;33459.330813383596;4335.6965012449145;4403.823847046115;4435.578620031124;4470.284754439274;4491.842785502492;318027;318673;320207;322955;323042;59369;60047.09929351063;60051.39948600545;60256.57690807761;60346.698266508385;37101;38259.61740382616;38330.61669383326;62473.68763156155;62539;16210.513684589481;16344.83655163457;16374.754378684329;16376.83623163777;16389.59026024359;12984.805227921588;13092.607221783363;13096.345182740824;13106.410211540504;13152.671183220496;20086.69869951952;20170.29403970854;20397.59204815925;20424.693629595567;20484.487887802625;7236.819079523054;7358.448116391292;7435.107787065586;7452.552846829208;7474.402047836269;1042.296449896317;1079.643717573199;1130.5421304371744;1180.2151569206553;1240.1814802230665;32524.34951300961;32852.67147328496;32906.341873162404;32989.67010329914;33075.33849323;1156.797560426922;1166.7783121206944;1190.345310079453;1231.2612432540404;1280.6862318731785;17229.7415538767;17293.481195564153;17308.65382692339;17331.65336693259;17486.387976421018;461039;461451;462113;462924;463196;59850.70074649686;60388;60418;60516.39483605196;60664.69667651634;1289.2135797163724;1367.3915107777143;1413.4770135050098;1429.685469196775;1440.6038339456525;32075.35849283048;34336.82831585926;34386.312273754884;34401.286738995426;34702.13244668904;51145.7442712784;51407.20074797364;51614.225786613984;51618.48381516287;51653.741731292605;348593;349324;349509;349616;350397;25916.611250830876;27961.720382795913;28815.855920720263;28825.279368015967;29095.854520727262;48403.27395089147;48404.75797620989;48881;48986.265206022654;49239.507604924926;38175.236495270496;38750;39169.60830391774;39328;39919;40686.79656601698;40980;41320.586794131676;41856.3721544171;42047.57952420559;40566.59433405628;41110.794446028776;41601;41876.162476750906;41967.1606567873;33972.320553588295;36620.26759464743;36718.26563468662;36781.816090919376;36913.815430922674;27577;27996.58005129884;28308.575371369858;28498;28558.42883142284 01:19:03 INFO - PROCESS | 26271 | |2;jquery.html;399.8120883184903;403.32443157710827;403.8041549848323;405.8234667919455;420.7377866400798;13290.800637990438;18843.434696959095;19523.31668391603;19568.41294761156;19647.803521964775;14473.067915690855;18573.53566160847;18779.3427230047;19266.61466770667;20083.799162008374;5724.284464441945;5871.647701137946;5914.4381283777975;5943.673097979609;5952.970235148819;5881.411858814127;5900.262467191601;5923.407659234085;5930.406959304079;5950.077737950603;4251.829926802924;6110.358412366704;6485.935140648604;6493.772717954873;6595.868082638344;6458;6515.4787616990525;6528.7714929977465;6557.3442655734525;6568.573042752229;5712.485876271114;5802.071668533014;5849;5851.297844258674;5863.794767183171;22475.775242247695;22785.20251791196;23387.76612233873;23587.410314742097;23709.407264818346;2370.348154257593;2372.750861159571;2390.3546042568582;2618.764311211981;2893.392387598607;13637.863621363858;14365;14469.421223151061;14638.634034149125;15174.620634484116;1976.337926794511;1993.8604297699167;2059.0425452164664;2060.917563297466;2081.063521415369;78032.21967780363;80241.59879200625;80622.99999999942;80978;81048.59475702643;10730.839037414446;10839.67480975572;10862.45687715611;11156.274842135235;11275.66173014811;15680.294386752623;15744.842551574568;15780.368785248691;15783;15818.60453488649;8290.922180116668;8480.194381533744;8598.5700714964;8689.522076285739;8739;8272.255497005299;8332;8356.206160414751;8424.620892059873;8424.747257582283;6032.8884890288045;6154.5076393888385;6595.538312318092;6809.216940051958;7004.334588214111;1860.7394964704952;1976.8220860122658;1993.900304984745;2002.0880059543101;2007.5081605006574;995.576879826071;1016.1261315268863;1056.730533713898;1118.976136834787;1148.5750272399266;19039.61920761577;19273.614527709367;19858;19963.500912477306;20093.799062009486;1058.7988282226352;1062.617457715222;1073.6510634043811;1118.0943435817014;1124.4321617583068;10936.398498082523;11452.541898323974;11543.595974141033;11573.942130289295;11622.53509859613;455792;459039;474814;477264;477887;77690.6115469419;81461.59269203617;81498.59250703709;81569.18430815735;81795.18204817995;1001.0740065439439;1005.215931573374;1009.9242556808268;1024.8770147582338;1061.2200032975602;17049.72712247748;17397.217125229647;17494.212760426068;17535.21091550858;17637.559061023578;37568;37697.43453848249;37808;38054.80972595119;38206.61793382031;48407.757961209965;58109;58843.21890378712;58905.70547147237;58995.41004589899;7683.423743219393;8156.551389673387;8342.207490288412;8659.177378149066;8875.73372798817;11191.16066295015;13377.866221337663;13582.758844790895;14132.646683832576;14289.857101429268;11779.764404711686;11988.460519276829;12066.215695979734;12201.877981220074;12413.875861241271;5843.561732869966;11112.888871111185;12133.575324863587;12135.635930922086;12150.359701440193;11959.581414650793;12127.151099422956;12149;12320.507179712711;12381.195222310522;9001.549922503718;9059.184673379428;9081.091890810865;9221.723348299562;9233.58448869816;8906.821863562822;11698.532058717896;12119.81820272679;12132.150749447454;12217.633470995885 01:19:03 INFO - PROCESS | 26271 | |3;mootools.html;1398.923059231743;1559.6646720954993;1592.036817725276;1721.294269349567;1838.3290099113829;8760.824783504326;9202.953985230073;9224.123708247722;9232.584533695992;9243.815123697523;8830.337724670659;9039.096090390958;9056.320775941798;9092.63629454821;9114.225290850285;2140.218820130649;2264.30938563738;2360.114956891166;2433.817463690226;2472.938176545592;2432.793212576933;2448.0574978633176;2454.055188752325;2458.323960910746;2461.8645974471397;2377.072941552796;2439.841410308324;2444.792192663617;2446.0338166424253;2447.5104979004273;2123.193186589094;2293.747687754354;2358.929232123039;2371.67982322386;2395.5927492326346;2360.5160942006846;2361;2365.467769751809;2366.621340585515;2373.181252467913;8961.641534338618;8967.596458159398;8981.595828187747;9040.954795225982;9104.68133615327;5405.945940540583;5579.442055794388;5582.218489411485;5632.127020311858;5633.380328163898;3423.863045478178;3444.8794292199655;3455.0844026333043;3541.8052007139595;3558.480729473554;1094.6332978452228;1134.3080720760329;1162.2155045344443;1177.4054102678092;1208.3052244959183;12648.304343261118;12663.30351830649;12696;12699.365031748468;12702.428390722347;4788.904221915612;4847.394075740533;4870.293807397908;4928.605711543068;4938.8022330063495;10686.0916822071;10715.46422678863;10722.249442538947;10728.409937453358;10731.517081731341;4934.8026078957155;5567.749451274622;5570.192322113271;5577.609567330248;5579.721013949367;4613.63090952723;4680.087382960358;4853.611711063107;4956.677815941952;4986.426560945465;4057.5739547347102;4176.31090870003;4184.8897184756;4189.937150942738;4201.579842015774;1309.0771006440436;1319.1758386722704;1320.1551007355301;1333.993330033363;1338.3843432021185;862.9309655227567;940.9952950235341;941.7363138321281;1019.2253887045898;1023.2019025160238;6139.386061393825;6354.777582784581;6389.3291204423795;6400.583962042452;6404.679766011774;464.9677715471648;470.15137676494254;475.38912497440623;479.5276652497287;489.4713709194062;4392;4394.714343567658;4453.688241823042;4475.082608065404;4479.932801007987;10900.454977251105;11206.719832004102;11418;11462.48418821155;11476.19666623345;11031.172662050378;11209;11295.604653837076;11333.716657083474;11363.318200907972;8518.87221691675;8530.14698530142;8550.401471897032;8643.567821608895;8704.521251331238;6208.2860471044605;6484.546081774419;6610.9669451652435;6624.138861947916;6667.966660166862;10313.74215644615;10458.63394781179;10491.213159013258;10588.788224235319;10690;10755.354678719303;10774.946125269324;10791.730206744895;10822.40476773785;10964.451777411257;7268.27317268269;7483.98966139586;8211.671533138608;8268.627911744106;8320.625571849403;8652.913470865211;8799.296056315607;8871.689490867788;8985.865212021694;9012.954935225282;7587.203343648837;7836.686532538634;7852.45032847718;7883.211678832071;7896.7236146734585;7760.961195193988;7764.767056988299;7821.726239581587;7964.880526792219;7969.083555391204;6989.650517474208;7122.358987691133;7236.927630723625;7277.59973201479;7284.307990740871;5308.734563271898;5341.893162136813;5436.809711660231;5476.863078423071;5588.245586845724;5425.538829199562;5502.80740174092;5511.917321240105;5610.831675049755;5688.232088667977 01:19:03 INFO - PROCESS | 26271 | |4;prototype.html;324.49378968808645;330.27834182311653;334.6887394722908;336.8753561182363;336.9258763072125;5283.735813209343;5322.520973112419;5334.626576139672;5355.357357117146;5411.891762164754;5286.867828304295;5304.734763261841;5310.061827432988;5327.813526526573;5334;3941.896269044658;3985.900352491182;4120.587941205886;4121.134561742023;4124.731892426998;4075.6535694466006;4107.774072426016;4122.113745544722;4123.7938103094875;4130.958690413087;3897.922041559167;4046.866877274368;4075.205334959684;4094.242565125461;4096.9795151024355;4018.1963607278517;4093.7339072960162;4098.7950602469755;4107.445494858186;4116.732412393215;3648.1426864686778;3651.415773476231;3660.4692319613505;3687.0597997510463;3688.8524459021605;5030.89938201234;5045.520675535855;5075.670081444694;5086.440491545927;5089.898202035939;4504.324351347292;4686.367340409035;4691.15559199344;4696.107739529512;4742;5411.188321751769;5450.890982180374;5463.508284254396;5468.4531546845;5507.339119305709;4039.899002524931;4040.252553277653;4049.919001619951;4058.8782336529953;4059.6955228357697;5597.3003374578175;5609.769367355312;5644.57665675076;5751.84305885293;5758.424157584208;4110.650594699484;4112.8202052912;4113.930378101655;4146.481689788777;4153.958460415418;4232.873013809591;4254.085371645111;4256.893577660521;4262.744235345889;4265.826897603122;4614.423197100363;4661.847373617574;4710.62315014798;4714.292856071548;4761.666683332202;5459.481349271813;5463.562914966793;5480.314960629921;5499.340079190522;5500.257465242221;1436.2100844535464;1450.985490145106;1455.44693016653;1466.442751754348;1472.7128209999162;956.789506308611;962.956666949989;1003.1924300937669;1011.9747006324753;1019.5361110694764;5185.170372740344;5216.191490319006;5216.921746173811;5219.530242278137;5234.450382709837;5534.584906132056;5557.944420555743;5576.888462230732;5612.579056570692;5630.634008789416;5011.924821127686;5232.3459567554055;5233.947660523346;5238.559396166009;5265.736713164327;2960.4671159191553;2963.8962636307624;2966.1546459259007;2982.4035192961496;2987.775916806248;5602.579806514527;5749.85625359361;5758.683272419973;5762.596618236683;5838;5788.392218817048;5811.418858114154;5812.651240925558;5839.474447299764;5845.912311315334;5933.58464907461;5937.70311484424;5962.34414214436;6045.516358691382;6046.637201767908;5499.807506737245;5644.435556444323;5648.971755141198;5681.971590142023;5740.885182296414;5587.74855131512;5593.860153496033;5597.860053498695;5613.137299976959;5669.971650141723;5622.85942851432;5885.558583106199;5914.048364039771;5985.311689155628;6014.1580178775885;4011.1576568920855;4016.718829681894;4031.903410226724;4039.5152581690386;4041.8989525260927;5709.573431291601;5725.885482290414;5738.426157384228;5802.912956305743;5837;5271.102403134945;5567.192757050286;5581.5813813963305;5586.547497650558;5597.496225339739;5450;5512;5527.391986881359;5544.63959842609;5546.362168350692;5130.820421285237;5273.841784746463;5425.647332923348;5438.374586922555;5443.210734443404;5551.8889622208135;5552.916706249329;5559.58303127259;5565.276514053147;5586.525145362527;5401.216823560483;5407.432219616883;5455.536279416294;5474.753636086465;5481.698506582176 01:19:03 INFO - PROCESS | 26271 | |5;yui.html;656.4879394072625;696.8257935516122;715.3132992327365;729.1942403643973;742.9895342334424;13904.374303156357;15105.320260588273;15257.847421525808;15329.386824527033;15372.461963831269;13908.443662253498;13956.720865582707;13961.720765584681;13994.090384125026;14013;654.3129713800514;759.8480303939207;794.7973266816954;797.972070977516;800.8718605023197;779.9103103143154;787.4291138924262;791.4934441957153;793.5040599625235;794.4121350200838;694.5901917868457;840.2731637133866;841.0370126205521;841.2344766262702;841.5203334099566;799.8200404908878;820.2248874813304;820.3027426687328;821.0639870547581;821.2608652212996;602.3223873142714;603.5865432178928;607.9118527813442;607.9817605471843;608.0635820835907;14087;14261.78607320891;14296.356663950148;14296.57110286693;14313.212773297464;13398.665033374244;13751.174929504261;13880.38030073986;14025.71948561023;14088.225147616877;11664.883351166465;11857.644270671808;11917.702057448547;12023.819642705366;12152.149349545536;4360.825566977317;4447.1995040892625;4509.842155524574;4537.546245375436;4630.976845115787;51816.74091629555;52195.73902130465;52348;52544.737276313754;52832.47167528314;10584.788304234025;10720;10739.87231340698;10907.781844363068;11063.889361106447;19666.410007699793;19769.209231630575;19807.504812379804;19835.801641983686;20007.899960500104;7896.249856263646;7986.560739159286;8009.719659811879;8027.317677997319;8049.678012879419;4092.3043082676018;4217.304144816071;4286.935695964563;4373.2128216921255;4456.3538286948215;3525.25969546393;3658.341498530237;3664.6623982246288;3665.9266814663556;3666.834992425347;675.7364627795164;682.6313790553145;691.2707094015761;696.0776970514089;704.1339152842033;646.7510008646611;736.2784471218237;758.616898466271;763.1605234242289;772.4129661457221;8545.74362769118;9019.458832470073;9317.16145546904;9379;9420.764480887896;618.4619381138439;621.2917274307293;665.5873358517654;666.5134451850176;676.8172593399754;3836.9808150959066;4039.4950631171105;4144.896377590584;4213.1784302060805;4399.318105693623;63545.68227158927;63789;64199.35800642027;64223.678881606225;64460.35539644637;54964;56615.43384566184;57202.427975720544;58020.84837859732;58442.123368149514;52175.73912130415;52526;53024.90213625482;53232.20151697728;53279.20081198707;8206.235659333033;8383.28742056932;8447.915520844714;8561.700340488052;8759.956200218958;32075.35849283048;32129.357412851143;32929.67070329266;34256.48615270723;35297.29405411929;45934.31098533591;46387.53612463832;46650.06699866051;46734;47484.7625761869;12549.49802007946;12600.11799174049;12671.936640317108;12701.814901030424;12820.679483013;13943.16341019542;13976.23130727779;14127.717445650824;14148.929255353658;14169.787453188417;12061.457234424297;12253.571125010581;12379.504819807107;12438.502459901865;12463.439145238304;13282.667933301746;13337.399817008063;13364.198148111145;13386.866131338562;13441.798373024218;13174.80237796453;13196.802047969097;13275.40260688252;13277.867221327662;13299.26854023038;10442.843357349799;10560.15518758513;10687.358758474516;10748.032677059102;10931;10497.842532361869;11087.33475991443;11105.278156919774;11131.443427828413;11218.607348743082 01:19:03 INFO - PROCESS | 26271 | __end_tp_report 01:19:03 INFO - PROCESS | 26271 | __start_cc_report 01:19:03 INFO - PROCESS | 26271 | _x_x_mozilla_cycle_collect,827 01:19:03 INFO - PROCESS | 26271 | __end_cc_report 01:19:03 INFO - PROCESS | 26271 | __startTimestamp1462954743184__endTimestamp 01:19:03 INFO - PROCESS | 26271 | 01:19:03 INFO - PROCESS | 26271 | ------- Summary: start ------- 01:19:03 INFO - PROCESS | 26271 | Number of tests: 6 01:19:03 INFO - PROCESS | 26271 | 01:19:03 INFO - PROCESS | 26271 | [#0] dojo.html Cycles:165 Average:5381.51 Median:5544.20 stddev:617.79 (11.1%) stddev-sans-first:594.73 01:19:03 INFO - PROCESS | 26271 | Values: 3166.0 3176.4 3224.6 3230.8 3252.6 5216.2 5280.3 5343.4 5444.7 5465.1 5357.8 5364.0 5368.2 5418.5 5435.4 4810.9 4816.6 4994.7 5003.2 5032.8 4946.1 4962.8 5020.5 5020.6 5023.5 4756.7 4779.7 4830.7 4845.9 4852.6 4842.1 4850.8 4851.1 4863.6 4897.9 4742.1 4794.4 4804.9 4828.3 4862.5 5297.2 5356.6 5362.2 5399.1 5424.8 5796.4 5873.5 5878.8 5879.2 5879.6 5611.2 5750.1 5900.7 5924.0 5928.4 5387.4 5486.8 5497.1 5511.0 5511.7 6043.5 6048.8 6048.8 6049.0 6049.2 5542.3 5653.7 5682.1 5770.1 5785.9 5827.7 5835.5 5838.1 5841.4 5876.5 5781.1 5816.3 5824.0 5830.3 5840.8 5537.6 5703.2 5738.1 5766.3 5841.3 4418.3 4431.2 4432.8 4435.0 4465.6 3928.7 3942.9 3957.6 3986.1 3991.1 5281.7 5325.1 5434.2 5479.3 5484.3 5907.9 5912.4 5920.6 5925.3 5931.1 5524.1 5543.0 5544.2 5544.4 5546.7 4894.7 4980.9 5020.6 5025.9 5054.0 6054.8 6058.5 6064.1 6064.2 6066.4 5632.9 5838.1 5839.4 5850.9 5851.8 5936.3 5944.5 5992.2 6037.3 6042.6 5617.3 5701.8 5712.9 5719.5 5730.9 5695.1 5779.8 5821.6 5827.2 5832.0 5637.9 5697.9 5703.5 5706.3 5745.9 5688.2 5691.5 5693.3 5694.8 5695.0 5336.6 5410.8 5419.8 5584.6 5596.6 5609.9 5635.8 5638.9 5640.1 5651.4 5443.8 5489.9 5497.0 5508.6 5542.2 01:19:03 INFO - PROCESS | 26271 | 01:19:03 INFO - PROCESS | 26271 | [#1] ext.html Cycles:180 Average:54758.50 Median:39623.50 stddev:100748.28 (254.3%) stddev-sans-first:100948.83 01:19:03 INFO - PROCESS | 26271 | Values: 594.9 612.9 643.8 647.3 651.5 33621.3 35825.0 35849.0 35899.6 44285.8 43048.8 47318.8 47380.8 47438.5 47444.8 8858.5 8895.6 8899.7 8905.6 8915.2 8674.1 8789.5 8796.7 8808.6 8874.8 8709.1 8783.3 8783.7 8814.5 8815.6 8772.4 8826.9 8922.8 8931.1 8942.3 8842.4 8845.1 8858.7 8909.8 8926.7 41605.4 41991.0 42110.0 42147.0 42179.9 3438.6 3546.1 3550.7 3561.7 3576.9 32016.0 32541.8 32886.3 33278.5 33459.3 4335.7 4403.8 4435.6 4470.3 4491.8 318027.0 318673.0 320207.0 322955.0 323042.0 59369.0 60047.1 60051.4 60256.6 60346.7 37101.0 38259.6 38330.6 62473.7 62539.0 16210.5 16344.8 16374.8 16376.8 16389.6 12984.8 13092.6 13096.3 13106.4 13152.7 20086.7 20170.3 20397.6 20424.7 20484.5 7236.8 7358.4 7435.1 7452.6 7474.4 1042.3 1079.6 1130.5 1180.2 1240.2 32524.3 32852.7 32906.3 32989.7 33075.3 1156.8 1166.8 1190.3 1231.3 1280.7 17229.7 17293.5 17308.7 17331.7 17486.4 461039.0 461451.0 462113.0 462924.0 463196.0 59850.7 60388.0 60418.0 60516.4 60664.7 1289.2 1367.4 1413.5 1429.7 1440.6 32075.4 34336.8 34386.3 34401.3 34702.1 51145.7 51407.2 51614.2 51618.5 51653.7 348593.0 349324.0 349509.0 349616.0 350397.0 25916.6 27961.7 28815.9 28825.3 29095.9 48403.3 48404.8 48881.0 48986.3 49239.5 38175.2 38750.0 39169.6 39328.0 39919.0 40686.8 40980.0 41320.6 41856.4 42047.6 40566.6 41110.8 41601.0 41876.2 41967.2 33972.3 36620.3 36718.3 36781.8 36913.8 27577.0 27996.6 28308.6 28498.0 28558.4 01:19:03 INFO - PROCESS | 26271 | 01:19:03 INFO - PROCESS | 26271 | [#2] jquery.html Cycles:180 Average:28182.73 Median:12978.88 stddev:77119.36 (594.2%) stddev-sans-first:77307.48 01:19:03 INFO - PROCESS | 26271 | Values: 399.8 403.3 403.8 405.8 420.7 13290.8 18843.4 19523.3 19568.4 19647.8 14473.1 18573.5 18779.3 19266.6 20083.8 5724.3 5871.6 5914.4 5943.7 5953.0 5881.4 5900.3 5923.4 5930.4 5950.1 4251.8 6110.4 6485.9 6493.8 6595.9 6458.0 6515.5 6528.8 6557.3 6568.6 5712.5 5802.1 5849.0 5851.3 5863.8 22475.8 22785.2 23387.8 23587.4 23709.4 2370.3 2372.8 2390.4 2618.8 2893.4 13637.9 14365.0 14469.4 14638.6 15174.6 1976.3 1993.9 2059.0 2060.9 2081.1 78032.2 80241.6 80623.0 80978.0 81048.6 10730.8 10839.7 10862.5 11156.3 11275.7 15680.3 15744.8 15780.4 15783.0 15818.6 8290.9 8480.2 8598.6 8689.5 8739.0 8272.3 8332.0 8356.2 8424.6 8424.7 6032.9 6154.5 6595.5 6809.2 7004.3 1860.7 1976.8 1993.9 2002.1 2007.5 995.6 1016.1 1056.7 1119.0 1148.6 19039.6 19273.6 19858.0 19963.5 20093.8 1058.8 1062.6 1073.7 1118.1 1124.4 10936.4 11452.5 11543.6 11573.9 11622.5 455792.0 459039.0 474814.0 477264.0 477887.0 77690.6 81461.6 81498.6 81569.2 81795.2 1001.1 1005.2 1009.9 1024.9 1061.2 17049.7 17397.2 17494.2 17535.2 17637.6 37568.0 37697.4 37808.0 38054.8 38206.6 48407.8 58109.0 58843.2 58905.7 58995.4 7683.4 8156.6 8342.2 8659.2 8875.7 11191.2 13377.9 13582.8 14132.6 14289.9 11779.8 11988.5 12066.2 12201.9 12413.9 5843.6 11112.9 12133.6 12135.6 12150.4 11959.6 12127.2 12149.0 12320.5 12381.2 9001.5 9059.2 9081.1 9221.7 9233.6 8906.8 11698.5 12119.8 12132.2 12217.6 01:19:03 INFO - PROCESS | 26271 | 01:19:03 INFO - PROCESS | 26271 | [#3] mootools.html Cycles:180 Average:6019.60 Median:472.77 stddev:3439.76 (727.6%) stddev-sans-first:3431.88 01:19:03 INFO - PROCESS | 26271 | Values: 1398.9 1559.7 1592.0 1721.3 1838.3 8760.8 9203.0 9224.1 9232.6 9243.8 8830.3 9039.1 9056.3 9092.6 9114.2 2140.2 2264.3 2360.1 2433.8 2472.9 2432.8 2448.1 2454.1 2458.3 2461.9 2377.1 2439.8 2444.8 2446.0 2447.5 2123.2 2293.7 2358.9 2371.7 2395.6 2360.5 2361.0 2365.5 2366.6 2373.2 8961.6 8967.6 8981.6 9041.0 9104.7 5405.9 5579.4 5582.2 5632.1 5633.4 3423.9 3444.9 3455.1 3541.8 3558.5 1094.6 1134.3 1162.2 1177.4 1208.3 12648.3 12663.3 12696.0 12699.4 12702.4 4788.9 4847.4 4870.3 4928.6 4938.8 10686.1 10715.5 10722.2 10728.4 10731.5 4934.8 5567.7 5570.2 5577.6 5579.7 4613.6 4680.1 4853.6 4956.7 4986.4 4057.6 4176.3 4184.9 4189.9 4201.6 1309.1 1319.2 1320.2 1334.0 1338.4 862.9 941.0 941.7 1019.2 1023.2 6139.4 6354.8 6389.3 6400.6 6404.7 465.0 470.2 475.4 479.5 489.5 4392.0 4394.7 4453.7 4475.1 4479.9 10900.5 11206.7 11418.0 11462.5 11476.2 11031.2 11209.0 11295.6 11333.7 11363.3 8518.9 8530.1 8550.4 8643.6 8704.5 6208.3 6484.5 6611.0 6624.1 6668.0 10313.7 10458.6 10491.2 10588.8 10690.0 10755.4 10774.9 10791.7 10822.4 10964.5 7268.3 7484.0 8211.7 8268.6 8320.6 8652.9 8799.3 8871.7 8985.9 9013.0 7587.2 7836.7 7852.5 7883.2 7896.7 7761.0 7764.8 7821.7 7964.9 7969.1 6989.7 7122.4 7236.9 7277.6 7284.3 5308.7 5341.9 5436.8 5476.9 5588.2 5425.5 5502.8 5511.9 5610.8 5688.2 01:19:03 INFO - PROCESS | 26271 | 01:19:03 INFO - PROCESS | 26271 | [#4] prototype.html Cycles:180 Average:4658.31 Median:5278.79 stddev:1358.45 (25.7%) stddev-sans-first:1322.74 01:19:03 INFO - PROCESS | 26271 | Values: 324.5 330.3 334.7 336.9 336.9 5283.7 5322.5 5334.6 5355.4 5411.9 5286.9 5304.7 5310.1 5327.8 5334.0 3941.9 3985.9 4120.6 4121.1 4124.7 4075.7 4107.8 4122.1 4123.8 4131.0 3897.9 4046.9 4075.2 4094.2 4097.0 4018.2 4093.7 4098.8 4107.4 4116.7 3648.1 3651.4 3660.5 3687.1 3688.9 5030.9 5045.5 5075.7 5086.4 5089.9 4504.3 4686.4 4691.2 4696.1 4742.0 5411.2 5450.9 5463.5 5468.5 5507.3 4039.9 4040.3 4049.9 4058.9 4059.7 5597.3 5609.8 5644.6 5751.8 5758.4 4110.7 4112.8 4113.9 4146.5 4154.0 4232.9 4254.1 4256.9 4262.7 4265.8 4614.4 4661.8 4710.6 4714.3 4761.7 5459.5 5463.6 5480.3 5499.3 5500.3 1436.2 1451.0 1455.4 1466.4 1472.7 956.8 963.0 1003.2 1012.0 1019.5 5185.2 5216.2 5216.9 5219.5 5234.5 5534.6 5557.9 5576.9 5612.6 5630.6 5011.9 5232.3 5233.9 5238.6 5265.7 2960.5 2963.9 2966.2 2982.4 2987.8 5602.6 5749.9 5758.7 5762.6 5838.0 5788.4 5811.4 5812.7 5839.5 5845.9 5933.6 5937.7 5962.3 6045.5 6046.6 5499.8 5644.4 5649.0 5682.0 5740.9 5587.7 5593.9 5597.9 5613.1 5670.0 5622.9 5885.6 5914.0 5985.3 6014.2 4011.2 4016.7 4031.9 4039.5 4041.9 5709.6 5725.9 5738.4 5802.9 5837.0 5271.1 5567.2 5581.6 5586.5 5597.5 5450.0 5512.0 5527.4 5544.6 5546.4 5130.8 5273.8 5425.6 5438.4 5443.2 5551.9 5552.9 5559.6 5565.3 5586.5 5401.2 5407.4 5455.5 5474.8 5481.7 01:19:03 INFO - PROCESS | 26271 | 01:19:03 INFO - PROCESS | 26271 | [#5] yui.html Cycles:180 Average:15053.18 Median:4451.78 stddev:17433.72 (391.6%) stddev-sans-first:17449.11 01:19:03 INFO - PROCESS | 26271 | Values: 656.5 696.8 715.3 729.2 743.0 13904.4 15105.3 15257.8 15329.4 15372.5 13908.4 13956.7 13961.7 13994.1 14013.0 654.3 759.8 794.8 798.0 800.9 779.9 787.4 791.5 793.5 794.4 694.6 840.3 841.0 841.2 841.5 799.8 820.2 820.3 821.1 821.3 602.3 603.6 607.9 608.0 608.1 14087.0 14261.8 14296.4 14296.6 14313.2 13398.7 13751.2 13880.4 14025.7 14088.2 11664.9 11857.6 11917.7 12023.8 12152.1 4360.8 4447.2 4509.8 4537.5 4631.0 51816.7 52195.7 52348.0 52544.7 52832.5 10584.8 10720.0 10739.9 10907.8 11063.9 19666.4 19769.2 19807.5 19835.8 20007.9 7896.2 7986.6 8009.7 8027.3 8049.7 4092.3 4217.3 4286.9 4373.2 4456.4 3525.3 3658.3 3664.7 3665.9 3666.8 675.7 682.6 691.3 696.1 704.1 646.8 736.3 758.6 763.2 772.4 8545.7 9019.5 9317.2 9379.0 9420.8 618.5 621.3 665.6 666.5 676.8 3837.0 4039.5 4144.9 4213.2 4399.3 63545.7 63789.0 64199.4 64223.7 64460.4 54964.0 56615.4 57202.4 58020.8 58442.1 52175.7 52526.0 53024.9 53232.2 53279.2 8206.2 8383.3 8447.9 8561.7 8760.0 32075.4 32129.4 32929.7 34256.5 35297.3 45934.3 46387.5 46650.1 46734.0 47484.8 12549.5 12600.1 12671.9 12701.8 12820.7 13943.2 13976.2 14127.7 14148.9 14169.8 12061.5 12253.6 12379.5 12438.5 12463.4 13282.7 13337.4 13364.2 13386.9 13441.8 13174.8 13196.8 13275.4 13277.9 13299.3 10442.8 10560.2 10687.4 10748.0 10931.0 10497.8 11087.3 11105.3 11131.4 11218.6 01:19:03 INFO - PROCESS | 26271 | -------- Summary: end -------- 01:19:03 INFO - PROCESS | 26271 | 01:19:03 INFO - TEST-INFO | 26271: exit 0 01:19:03 INFO - TEST-OK | dromaeo_css | took 1112635ms 01:19:03 INFO - TEST-START | kraken 01:19:03 INFO - operating with platform_type : linux_ 01:19:03 INFO - Initialising browser for kraken test... 01:19:03 INFO - TEST-INFO | started process 26457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplHJ7P9/profile http://localhost:58568/getInfo.html) 01:19:08 INFO - PROCESS | 26457 | __metrics Screen width/height:1600/1200 01:19:08 INFO - PROCESS | 26457 | colorDepth:24 01:19:08 INFO - PROCESS | 26457 | Browser inner width/height: 1024/697 01:19:08 INFO - PROCESS | 26457 | __metrics 01:19:08 ERROR - PROCESS | 26457 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:19:09 INFO - TEST-INFO | 26457: exit 0 01:19:09 INFO - Browser initialized. 01:19:09 INFO - Running cycle 1/1 for kraken test... 01:19:09 INFO - TEST-INFO | started process 26537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplHJ7P9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:19:21 INFO - PROCESS | 26537 | RSS: Main: 152358912 01:19:21 INFO - PROCESS | 26537 | 01:19:24 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58568/tests/kraken/driver.html?testName=audio-beat-detection) 01:19:25 INFO - PROCESS | 26537 | RSS: Main: 208199680 01:19:25 INFO - PROCESS | 26537 | 01:19:27 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58568/tests/kraken/driver.html?testName=audio-dft) 01:19:28 INFO - PROCESS | 26537 | RSS: Main: 197267456 01:19:28 INFO - PROCESS | 26537 | 01:19:31 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58568/tests/kraken/driver.html?testName=audio-fft) 01:19:32 INFO - PROCESS | 26537 | RSS: Main: 264908800 01:19:32 INFO - PROCESS | 26537 | 01:19:34 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58568/tests/kraken/driver.html?testName=audio-oscillator) 01:19:34 INFO - PROCESS | 26537 | RSS: Main: 174620672 01:19:34 INFO - PROCESS | 26537 | 01:19:37 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58568/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:19:37 INFO - PROCESS | 26537 | RSS: Main: 178188288 01:19:37 INFO - PROCESS | 26537 | 01:19:41 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58568/tests/kraken/driver.html?testName=imaging-darkroom) 01:19:41 INFO - PROCESS | 26537 | RSS: Main: 214155264 01:19:41 INFO - PROCESS | 26537 | 01:19:45 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58568/tests/kraken/driver.html?testName=imaging-desaturate) 01:19:45 INFO - PROCESS | 26537 | RSS: Main: 212385792 01:19:45 INFO - PROCESS | 26537 | 01:19:48 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58568/tests/kraken/driver.html?testName=json-parse-financial) 01:19:49 INFO - PROCESS | 26537 | RSS: Main: 213188608 01:19:49 INFO - PROCESS | 26537 | 01:19:50 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58568/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:19:51 INFO - PROCESS | 26537 | RSS: Main: 202739712 01:19:51 INFO - PROCESS | 26537 | 01:19:53 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58568/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:19:53 INFO - PROCESS | 26537 | RSS: Main: 207130624 01:19:53 INFO - PROCESS | 26537 | 01:19:56 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58568/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:19:56 INFO - PROCESS | 26537 | RSS: Main: 216498176 01:19:56 INFO - PROCESS | 26537 | 01:19:59 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:20:00 INFO - PROCESS | 26537 | RSS: Main: 223219712 01:20:00 INFO - PROCESS | 26537 | 01:20:02 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:20:03 INFO - PROCESS | 26537 | RSS: Main: 217833472 01:20:03 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | Cycle 1(1): loaded http://localhost:58568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58568/tests/kraken/driver.html?testName=ai-astar) 01:20:05 INFO - PROCESS | 26537 | RSS: Main: 263905280 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | __start_tp_report 01:20:05 INFO - PROCESS | 26537 | _x_x_mozilla_page_load 01:20:05 INFO - PROCESS | 26537 | _x_x_mozilla_page_load_details 01:20:05 INFO - PROCESS | 26537 | |i|pagename|runs| 01:20:05 INFO - PROCESS | 26537 | |0;ai-astar;111;106;112;112;112;111;111;112;110;111 01:20:05 INFO - PROCESS | 26537 | |1;audio-beat-detection;154;125;159;204;125;157;167;125;178;130 01:20:05 INFO - PROCESS | 26537 | |2;audio-dft;161;161;161;161;164;161;161;161;162;161 01:20:05 INFO - PROCESS | 26537 | |3;audio-fft;76;77;75;159;76;74;76;74;134;77 01:20:05 INFO - PROCESS | 26537 | |4;audio-oscillator;91;92;149;92;92;91;135;91;91;123 01:20:05 INFO - PROCESS | 26537 | |5;imaging-gaussian-blur;116;116;116;116;116;117;117;116;116;117 01:20:05 INFO - PROCESS | 26537 | |6;imaging-darkroom;145;146;147;145;145;145;146;145;146;145 01:20:05 INFO - PROCESS | 26537 | |7;imaging-desaturate;95;96;96;95;95;94;94;95;94;95 01:20:05 INFO - PROCESS | 26537 | |8;json-parse-financial;58;56;58;57;57;58;57;110;54;55 01:20:05 INFO - PROCESS | 26537 | |9;json-stringify-tinderbox;60;61;60;59;61;60;61;62;60;60 01:20:05 INFO - PROCESS | 26537 | |10;stanford-crypto-aes;85;79;80;80;83;79;81;84;79;81 01:20:05 INFO - PROCESS | 26537 | |11;stanford-crypto-ccm;128;124;125;137;124;122;121;124;187;124 01:20:05 INFO - PROCESS | 26537 | |12;stanford-crypto-pbkdf2;169;172;168;167;168;168;167;170;167;168 01:20:05 INFO - PROCESS | 26537 | |13;stanford-crypto-sha256-iterative;67;65;65;65;64;65;65;64;64;65 01:20:05 INFO - PROCESS | 26537 | __end_tp_report 01:20:05 INFO - PROCESS | 26537 | __start_cc_report 01:20:05 INFO - PROCESS | 26537 | _x_x_mozilla_cycle_collect,1876 01:20:05 INFO - PROCESS | 26537 | __end_cc_report 01:20:05 INFO - PROCESS | 26537 | __startTimestamp1462954805487__endTimestamp 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | ------- Summary: start ------- 01:20:05 INFO - PROCESS | 26537 | Number of tests: 14 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:1.81 (1.6%) stddev-sans-first:1.92 01:20:05 INFO - PROCESS | 26537 | Values: 111.0 106.0 112.0 112.0 112.0 111.0 111.0 112.0 110.0 111.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:158.00 stddev:26.57 (16.8%) stddev-sans-first:28.17 01:20:05 INFO - PROCESS | 26537 | Values: 154.0 125.0 159.0 204.0 125.0 157.0 167.0 125.0 178.0 130.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 01:20:05 INFO - PROCESS | 26537 | Values: 161.0 161.0 161.0 161.0 164.0 161.0 161.0 161.0 162.0 161.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#3] audio-fft Cycles:10 Average:89.80 Median:76.00 stddev:30.48 (40.1%) stddev-sans-first:31.91 01:20:05 INFO - PROCESS | 26537 | Values: 76.0 77.0 75.0 159.0 76.0 74.0 76.0 74.0 134.0 77.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:91.00 stddev:22.24 (24.4%) stddev-sans-first:23.03 01:20:05 INFO - PROCESS | 26537 | Values: 91.0 92.0 149.0 92.0 92.0 91.0 135.0 91.0 91.0 123.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 01:20:05 INFO - PROCESS | 26537 | Values: 116.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 01:20:05 INFO - PROCESS | 26537 | Values: 145.0 146.0 147.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 01:20:05 INFO - PROCESS | 26537 | Values: 95.0 96.0 96.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:57.00 stddev:16.92 (29.7%) stddev-sans-first:17.88 01:20:05 INFO - PROCESS | 26537 | Values: 58.0 56.0 58.0 57.0 57.0 58.0 57.0 110.0 54.0 55.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 01:20:05 INFO - PROCESS | 26537 | Values: 60.0 61.0 60.0 59.0 61.0 60.0 61.0 62.0 60.0 60.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:2.18 (2.7%) stddev-sans-first:1.80 01:20:05 INFO - PROCESS | 26537 | Values: 85.0 79.0 80.0 80.0 83.0 79.0 81.0 84.0 79.0 81.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:124.50 stddev:19.97 (16.0%) stddev-sans-first:21.14 01:20:05 INFO - PROCESS | 26537 | Values: 128.0 124.0 125.0 137.0 124.0 122.0 121.0 124.0 187.0 124.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:168.00 stddev:1.58 (0.9%) stddev-sans-first:1.66 01:20:05 INFO - PROCESS | 26537 | Values: 169.0 172.0 168.0 167.0 168.0 168.0 167.0 170.0 167.0 168.0 01:20:05 INFO - PROCESS | 26537 | 01:20:05 INFO - PROCESS | 26537 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.50 01:20:05 INFO - PROCESS | 26537 | Values: 67.0 65.0 65.0 65.0 64.0 65.0 65.0 64.0 64.0 65.0 01:20:05 INFO - PROCESS | 26537 | -------- Summary: end -------- 01:20:05 INFO - PROCESS | 26537 | 01:20:06 INFO - TEST-INFO | 26537: exit 0 01:20:06 INFO - TEST-OK | kraken | took 62613ms 01:20:06 INFO - SUITE-END | took 1175s 01:20:06 INFO - Completed test suite (00:19:35) 01:20:06 INFO - javascript benchmark 01:20:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3165.9683403165977, 3176.364727054589, 3224.645289018208, 3230.8384580770985, 3252.5609042779233, 5216.191490318997, 5280.313559237294, 5343.358796944367, 5444.673319600822, 5465.125579907216, 5357.8392648220615, 5364.0, 5368.194770784385, 5418.485243901833, 5435.374931882835, 4810.855674329759, 4816.63875209359, 4994.700317980914, 5003.224500202475, 5032.798688052473, 4946.109700253953, 4962.826301079463, 5020.548150666439, 5020.6234532410035, 5023.522765337287, 4756.738379389132, 4779.713217206961, 4830.7101573905675, 4845.878853028667, 4852.587530059949, 4842.080004799077, 4850.781714822841, 4851.078295123915, 4863.610911127102, 4897.853064408074, 4742.075295317414, 4794.35276237707, 4804.855854324376, 4828.348172996635, 4862.5380588844, 5297.231901374279, 5356.598255130842, 5362.168863826113, 5399.1091469907415, 5424.810131645373, 5796.42035796417, 5873.530117590582, 5878.794242201545, 5879.176915231871, 5879.617824841372, 5611.2144299798065, 5750.079987202028, 5900.734466948955, 5923.970380148115, 5928.377520360344, 5387.380451248078, 5486.835394938198, 5497.092979658391, 5510.972445137749, 5511.696856672881, 6043.456088951927, 6048.788292409745, 6048.848778780566, 6049.0, 6049.243844519435, 5542.334919809568, 5653.717314134276, 5682.090865461589, 5770.13447982806, 5785.88428231433, 5827.65034097947, 5835.4748072673665, 5838.065909454552, 5841.415858414124, 5876.471117599351, 5781.075027995501, 5816.331121920949, 5824.0, 5830.271216097988, 5840.766369345263, 5537.640053396597, 5703.201551782754, 5738.110592858114, 5766.279215098113, 5841.32824725162, 4418.270985287391, 4431.224535706238, 4432.800523976429, 4435.046465009974, 4465.575770301816, 3928.744631598937, 3942.8817135485983, 3957.56466788653, 3986.123052928351, 3991.102002049574, 5281.683099014072, 5325.121354976463, 5434.157705555645, 5479.3424789024775, 5484.314460692413, 5907.852303692442, 5912.438318359749, 5920.644761314335, 5925.318588362394, 5931.11033344993, 5524.14375771756, 5543.029969755276, 5544.1960915667005, 5544.362398324244, 5546.722663866871, 4894.730789806595, 4980.90038199234, 5020.573251273682, 5025.874353141127, 5054.039732450822, 6054.788082417094, 6058.545609079337, 6064.06007068905, 6064.151018857364, 6066.363031881677, 5632.85917852057, 5838.095095260326, 5839.445252700986, 5850.882982340244, 5851.824445266649, 5936.3470018297085, 5944.464998150014, 5992.191054207626, 6037.305709843248, 6042.637441753509, 5617.269754931833, 5701.828945131652, 5712.942870571241, 5719.542436604978, 5730.942690573041, 5695.145728140812, 5779.826605201851, 5821.563382746226, 5827.24245848037, 5832.0, 5637.887242255214, 5697.914531281951, 5703.458171473703, 5706.343770466449, 5745.8563535911935, 5688.203651488712, 5691.516221121251, 5693.259876216065, 5694.772209111755, 5695.0, 5336.573074153981, 5410.83767486976, 5419.810306639406, 5584.581156413204, 5596.608237423341, 5609.859753506032, 5635.774569017193, 5638.9436105638415, 5640.125780504029, 5651.406602306699, 5443.836684899459, 5489.890202195854, 5496.983058134258, 5508.614396992172, 5542.224088627676], "value": 5340.225987678345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.881023795241, 612.9233845769279, 643.7714611312987, 647.3494138390917, 651.4690527220315, 33621.32757344855, 35825.0, 35848.99999999997, 35899.64100358995, 44285.77857110718, 43048.78475607625, 47318.76340618301, 47380.76309618447, 47438.52561474384, 47444.76277618616, 8858.512781797015, 8895.555222238894, 8899.68851090212, 8905.599248033854, 8915.1976322131, 8674.132586741307, 8789.472631642122, 8796.736097917073, 8808.603612837438, 8874.822503549958, 8709.129087091304, 8783.297336213087, 8783.73648790534, 8814.471131732085, 8815.559222038904, 8772.429792063496, 8826.86759698605, 8922.821543569125, 8931.062238464998, 8942.284617230605, 8842.381033327669, 8845.071267516882, 8858.73423797287, 8909.821803563893, 8926.73219803407, 41605.375919361235, 41991.0, 42110.0, 42147.0, 42179.9455013624, 3438.5529881115544, 3546.131197856516, 3550.680438760498, 3561.679448849616, 3576.8926932192076, 32016.0, 32541.83729081363, 32886.342273154645, 33278.50082248768, 33459.330813383596, 4335.6965012449145, 4403.823847046115, 4435.578620031124, 4470.284754439274, 4491.842785502492, 318027.0, 318673.0, 320207.0, 322955.0, 323042.0, 59369.0, 60047.09929351063, 60051.39948600545, 60256.57690807761, 60346.698266508385, 37101.0, 38259.61740382616, 38330.61669383326, 62473.68763156155, 62539.0, 16210.513684589481, 16344.83655163457, 16374.754378684329, 16376.83623163777, 16389.59026024359, 12984.805227921588, 13092.607221783363, 13096.345182740824, 13106.410211540504, 13152.671183220496, 20086.69869951952, 20170.29403970854, 20397.59204815925, 20424.693629595567, 20484.487887802625, 7236.819079523054, 7358.448116391292, 7435.107787065586, 7452.552846829208, 7474.402047836269, 1042.296449896317, 1079.643717573199, 1130.5421304371744, 1180.2151569206553, 1240.1814802230665, 32524.34951300961, 32852.67147328496, 32906.341873162404, 32989.67010329914, 33075.33849323, 1156.797560426922, 1166.7783121206944, 1190.345310079453, 1231.2612432540404, 1280.6862318731785, 17229.7415538767, 17293.481195564153, 17308.65382692339, 17331.65336693259, 17486.387976421018, 461039.0, 461451.0, 462113.0, 462924.0, 463196.0, 59850.70074649686, 60388.0, 60418.0, 60516.39483605196, 60664.69667651634, 1289.2135797163724, 1367.3915107777143, 1413.4770135050098, 1429.685469196775, 1440.6038339456525, 32075.35849283048, 34336.82831585926, 34386.312273754884, 34401.286738995426, 34702.13244668904, 51145.7442712784, 51407.20074797364, 51614.225786613984, 51618.48381516287, 51653.741731292605, 348593.0, 349324.0, 349509.0, 349616.0, 350397.0, 25916.611250830876, 27961.720382795913, 28815.855920720263, 28825.279368015967, 29095.854520727262, 48403.27395089147, 48404.75797620989, 48881.0, 48986.265206022654, 49239.507604924926, 38175.236495270496, 38750.0, 39169.60830391774, 39328.0, 39919.0, 40686.79656601698, 40980.0, 41320.586794131676, 41856.3721544171, 42047.57952420559, 40566.59433405628, 41110.794446028776, 41601.0, 41876.162476750906, 41967.1606567873, 33972.320553588295, 36620.26759464743, 36718.26563468662, 36781.816090919376, 36913.815430922674, 27577.0, 27996.58005129884, 28308.575371369858, 28498.0, 28558.42883142284], "value": 19969.318249505668, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.8120883184903, 403.32443157710827, 403.8041549848323, 405.8234667919455, 420.7377866400798, 13290.800637990438, 18843.434696959095, 19523.31668391603, 19568.41294761156, 19647.803521964775, 14473.067915690855, 18573.53566160847, 18779.3427230047, 19266.61466770667, 20083.799162008374, 5724.284464441945, 5871.647701137946, 5914.4381283777975, 5943.673097979609, 5952.970235148819, 5881.411858814127, 5900.262467191601, 5923.407659234085, 5930.406959304079, 5950.077737950603, 4251.829926802924, 6110.358412366704, 6485.935140648604, 6493.772717954873, 6595.868082638344, 6458.0, 6515.4787616990525, 6528.7714929977465, 6557.3442655734525, 6568.573042752229, 5712.485876271114, 5802.071668533014, 5849.0, 5851.297844258674, 5863.794767183171, 22475.775242247695, 22785.20251791196, 23387.76612233873, 23587.410314742097, 23709.407264818346, 2370.348154257593, 2372.750861159571, 2390.3546042568582, 2618.764311211981, 2893.392387598607, 13637.863621363858, 14365.0, 14469.421223151061, 14638.634034149125, 15174.620634484116, 1976.337926794511, 1993.8604297699167, 2059.0425452164664, 2060.917563297466, 2081.063521415369, 78032.21967780363, 80241.59879200625, 80622.99999999942, 80978.0, 81048.59475702643, 10730.839037414446, 10839.67480975572, 10862.45687715611, 11156.274842135235, 11275.66173014811, 15680.294386752623, 15744.842551574568, 15780.368785248691, 15783.0, 15818.60453488649, 8290.922180116668, 8480.194381533744, 8598.5700714964, 8689.522076285739, 8739.0, 8272.255497005299, 8332.0, 8356.206160414751, 8424.620892059873, 8424.747257582283, 6032.8884890288045, 6154.5076393888385, 6595.538312318092, 6809.216940051958, 7004.334588214111, 1860.7394964704952, 1976.8220860122658, 1993.900304984745, 2002.0880059543101, 2007.5081605006574, 995.576879826071, 1016.1261315268863, 1056.730533713898, 1118.976136834787, 1148.5750272399266, 19039.61920761577, 19273.614527709367, 19858.0, 19963.500912477306, 20093.799062009486, 1058.7988282226352, 1062.617457715222, 1073.6510634043811, 1118.0943435817014, 1124.4321617583068, 10936.398498082523, 11452.541898323974, 11543.595974141033, 11573.942130289295, 11622.53509859613, 455792.0, 459039.0, 474814.0, 477264.0, 477887.0, 77690.6115469419, 81461.59269203617, 81498.59250703709, 81569.18430815735, 81795.18204817995, 1001.0740065439439, 1005.215931573374, 1009.9242556808268, 1024.8770147582338, 1061.2200032975602, 17049.72712247748, 17397.217125229647, 17494.212760426068, 17535.21091550858, 17637.559061023578, 37568.0, 37697.43453848249, 37808.0, 38054.80972595119, 38206.61793382031, 48407.757961209965, 58109.0, 58843.21890378712, 58905.70547147237, 58995.41004589899, 7683.423743219393, 8156.551389673387, 8342.207490288412, 8659.177378149066, 8875.73372798817, 11191.16066295015, 13377.866221337663, 13582.758844790895, 14132.646683832576, 14289.857101429268, 11779.764404711686, 11988.460519276829, 12066.215695979734, 12201.877981220074, 12413.875861241271, 5843.561732869966, 11112.888871111185, 12133.575324863587, 12135.635930922086, 12150.359701440193, 11959.581414650793, 12127.151099422956, 12149.0, 12320.507179712711, 12381.195222310522, 9001.549922503718, 9059.184673379428, 9081.091890810865, 9221.723348299562, 9233.58448869816, 8906.821863562822, 11698.532058717896, 12119.81820272679, 12132.150749447454, 12217.633470995885], "value": 9505.739286340857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.923059231743, 1559.6646720954993, 1592.036817725276, 1721.294269349567, 1838.3290099113829, 8760.824783504326, 9202.953985230073, 9224.123708247722, 9232.584533695992, 9243.815123697523, 8830.337724670659, 9039.096090390958, 9056.320775941798, 9092.63629454821, 9114.225290850285, 2140.218820130649, 2264.30938563738, 2360.114956891166, 2433.817463690226, 2472.938176545592, 2432.793212576933, 2448.0574978633176, 2454.055188752325, 2458.323960910746, 2461.8645974471397, 2377.072941552796, 2439.841410308324, 2444.792192663617, 2446.0338166424253, 2447.5104979004273, 2123.193186589094, 2293.747687754354, 2358.929232123039, 2371.67982322386, 2395.5927492326346, 2360.5160942006846, 2361.0, 2365.467769751809, 2366.621340585515, 2373.181252467913, 8961.641534338618, 8967.596458159398, 8981.595828187747, 9040.954795225982, 9104.68133615327, 5405.945940540583, 5579.442055794388, 5582.218489411485, 5632.127020311858, 5633.380328163898, 3423.863045478178, 3444.8794292199655, 3455.0844026333043, 3541.8052007139595, 3558.480729473554, 1094.6332978452228, 1134.3080720760329, 1162.2155045344443, 1177.4054102678092, 1208.3052244959183, 12648.304343261118, 12663.30351830649, 12696.0, 12699.365031748468, 12702.428390722347, 4788.904221915612, 4847.394075740533, 4870.293807397908, 4928.605711543068, 4938.8022330063495, 10686.0916822071, 10715.46422678863, 10722.249442538947, 10728.409937453358, 10731.517081731341, 4934.8026078957155, 5567.749451274622, 5570.192322113271, 5577.609567330248, 5579.721013949367, 4613.63090952723, 4680.087382960358, 4853.611711063107, 4956.677815941952, 4986.426560945465, 4057.5739547347102, 4176.31090870003, 4184.8897184756, 4189.937150942738, 4201.579842015774, 1309.0771006440436, 1319.1758386722704, 1320.1551007355301, 1333.993330033363, 1338.3843432021185, 862.9309655227567, 940.9952950235341, 941.7363138321281, 1019.2253887045898, 1023.2019025160238, 6139.386061393825, 6354.777582784581, 6389.3291204423795, 6400.583962042452, 6404.679766011774, 464.9677715471648, 470.15137676494254, 475.38912497440623, 479.5276652497287, 489.4713709194062, 4392.0, 4394.714343567658, 4453.688241823042, 4475.082608065404, 4479.932801007987, 10900.454977251105, 11206.719832004102, 11418.0, 11462.48418821155, 11476.19666623345, 11031.172662050378, 11209.0, 11295.604653837076, 11333.716657083474, 11363.318200907972, 8518.87221691675, 8530.14698530142, 8550.401471897032, 8643.567821608895, 8704.521251331238, 6208.2860471044605, 6484.546081774419, 6610.9669451652435, 6624.138861947916, 6667.966660166862, 10313.74215644615, 10458.63394781179, 10491.213159013258, 10588.788224235319, 10690.0, 10755.354678719303, 10774.946125269324, 10791.730206744895, 10822.40476773785, 10964.451777411257, 7268.27317268269, 7483.98966139586, 8211.671533138608, 8268.627911744106, 8320.625571849403, 8652.913470865211, 8799.296056315607, 8871.689490867788, 8985.865212021694, 9012.954935225282, 7587.203343648837, 7836.686532538634, 7852.45032847718, 7883.211678832071, 7896.7236146734585, 7760.961195193988, 7764.767056988299, 7821.726239581587, 7964.880526792219, 7969.083555391204, 6989.650517474208, 7122.358987691133, 7236.927630723625, 7277.59973201479, 7284.307990740871, 5308.734563271898, 5341.893162136813, 5436.809711660231, 5476.863078423071, 5588.245586845724, 5425.538829199562, 5502.80740174092, 5511.917321240105, 5610.831675049755, 5688.232088667977], "value": 4725.40613678897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.49378968808645, 330.27834182311653, 334.6887394722908, 336.8753561182363, 336.9258763072125, 5283.735813209343, 5322.520973112419, 5334.626576139672, 5355.357357117146, 5411.891762164754, 5286.867828304295, 5304.734763261841, 5310.061827432988, 5327.813526526573, 5334.0, 3941.896269044658, 3985.900352491182, 4120.587941205886, 4121.134561742023, 4124.731892426998, 4075.6535694466006, 4107.774072426016, 4122.113745544722, 4123.7938103094875, 4130.958690413087, 3897.922041559167, 4046.866877274368, 4075.205334959684, 4094.242565125461, 4096.9795151024355, 4018.1963607278517, 4093.7339072960162, 4098.7950602469755, 4107.445494858186, 4116.732412393215, 3648.1426864686778, 3651.415773476231, 3660.4692319613505, 3687.0597997510463, 3688.8524459021605, 5030.89938201234, 5045.520675535855, 5075.670081444694, 5086.440491545927, 5089.898202035939, 4504.324351347292, 4686.367340409035, 4691.15559199344, 4696.107739529512, 4742.0, 5411.188321751769, 5450.890982180374, 5463.508284254396, 5468.4531546845, 5507.339119305709, 4039.899002524931, 4040.252553277653, 4049.919001619951, 4058.8782336529953, 4059.6955228357697, 5597.3003374578175, 5609.769367355312, 5644.57665675076, 5751.84305885293, 5758.424157584208, 4110.650594699484, 4112.8202052912, 4113.930378101655, 4146.481689788777, 4153.958460415418, 4232.873013809591, 4254.085371645111, 4256.893577660521, 4262.744235345889, 4265.826897603122, 4614.423197100363, 4661.847373617574, 4710.62315014798, 4714.292856071548, 4761.666683332202, 5459.481349271813, 5463.562914966793, 5480.314960629921, 5499.340079190522, 5500.257465242221, 1436.2100844535464, 1450.985490145106, 1455.44693016653, 1466.442751754348, 1472.7128209999162, 956.789506308611, 962.956666949989, 1003.1924300937669, 1011.9747006324753, 1019.5361110694764, 5185.170372740344, 5216.191490319006, 5216.921746173811, 5219.530242278137, 5234.450382709837, 5534.584906132056, 5557.944420555743, 5576.888462230732, 5612.579056570692, 5630.634008789416, 5011.924821127686, 5232.3459567554055, 5233.947660523346, 5238.559396166009, 5265.736713164327, 2960.4671159191553, 2963.8962636307624, 2966.1546459259007, 2982.4035192961496, 2987.775916806248, 5602.579806514527, 5749.85625359361, 5758.683272419973, 5762.596618236683, 5838.0, 5788.392218817048, 5811.418858114154, 5812.651240925558, 5839.474447299764, 5845.912311315334, 5933.58464907461, 5937.70311484424, 5962.34414214436, 6045.516358691382, 6046.637201767908, 5499.807506737245, 5644.435556444323, 5648.971755141198, 5681.971590142023, 5740.885182296414, 5587.74855131512, 5593.860153496033, 5597.860053498695, 5613.137299976959, 5669.971650141723, 5622.85942851432, 5885.558583106199, 5914.048364039771, 5985.311689155628, 6014.1580178775885, 4011.1576568920855, 4016.718829681894, 4031.903410226724, 4039.5152581690386, 4041.8989525260927, 5709.573431291601, 5725.885482290414, 5738.426157384228, 5802.912956305743, 5837.0, 5271.102403134945, 5567.192757050286, 5581.5813813963305, 5586.547497650558, 5597.496225339739, 5450.0, 5512.0, 5527.391986881359, 5544.63959842609, 5546.362168350692, 5130.820421285237, 5273.841784746463, 5425.647332923348, 5438.374586922555, 5443.210734443404, 5551.8889622208135, 5552.916706249329, 5559.58303127259, 5565.276514053147, 5586.525145362527, 5401.216823560483, 5407.432219616883, 5455.536279416294, 5474.753636086465, 5481.698506582176], "value": 4230.3638842151395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.4879394072625, 696.8257935516122, 715.3132992327365, 729.1942403643973, 742.9895342334424, 13904.374303156357, 15105.320260588273, 15257.847421525808, 15329.386824527033, 15372.461963831269, 13908.443662253498, 13956.720865582707, 13961.720765584681, 13994.090384125026, 14013.0, 654.3129713800514, 759.8480303939207, 794.7973266816954, 797.972070977516, 800.8718605023197, 779.9103103143154, 787.4291138924262, 791.4934441957153, 793.5040599625235, 794.4121350200838, 694.5901917868457, 840.2731637133866, 841.0370126205521, 841.2344766262702, 841.5203334099566, 799.8200404908878, 820.2248874813304, 820.3027426687328, 821.0639870547581, 821.2608652212996, 602.3223873142714, 603.5865432178928, 607.9118527813442, 607.9817605471843, 608.0635820835907, 14087.0, 14261.78607320891, 14296.356663950148, 14296.57110286693, 14313.212773297464, 13398.665033374244, 13751.174929504261, 13880.38030073986, 14025.71948561023, 14088.225147616877, 11664.883351166465, 11857.644270671808, 11917.702057448547, 12023.819642705366, 12152.149349545536, 4360.825566977317, 4447.1995040892625, 4509.842155524574, 4537.546245375436, 4630.976845115787, 51816.74091629555, 52195.73902130465, 52348.0, 52544.737276313754, 52832.47167528314, 10584.788304234025, 10720.0, 10739.87231340698, 10907.781844363068, 11063.889361106447, 19666.410007699793, 19769.209231630575, 19807.504812379804, 19835.801641983686, 20007.899960500104, 7896.249856263646, 7986.560739159286, 8009.719659811879, 8027.317677997319, 8049.678012879419, 4092.3043082676018, 4217.304144816071, 4286.935695964563, 4373.2128216921255, 4456.3538286948215, 3525.25969546393, 3658.341498530237, 3664.6623982246288, 3665.9266814663556, 3666.834992425347, 675.7364627795164, 682.6313790553145, 691.2707094015761, 696.0776970514089, 704.1339152842033, 646.7510008646611, 736.2784471218237, 758.616898466271, 763.1605234242289, 772.4129661457221, 8545.74362769118, 9019.458832470073, 9317.16145546904, 9379.0, 9420.764480887896, 618.4619381138439, 621.2917274307293, 665.5873358517654, 666.5134451850176, 676.8172593399754, 3836.9808150959066, 4039.4950631171105, 4144.896377590584, 4213.1784302060805, 4399.318105693623, 63545.68227158927, 63789.0, 64199.35800642027, 64223.678881606225, 64460.35539644637, 54964.0, 56615.43384566184, 57202.427975720544, 58020.84837859732, 58442.123368149514, 52175.73912130415, 52526.0, 53024.90213625482, 53232.20151697728, 53279.20081198707, 8206.235659333033, 8383.28742056932, 8447.915520844714, 8561.700340488052, 8759.956200218958, 32075.35849283048, 32129.357412851143, 32929.67070329266, 34256.48615270723, 35297.29405411929, 45934.31098533591, 46387.53612463832, 46650.06699866051, 46734.0, 47484.7625761869, 12549.49802007946, 12600.11799174049, 12671.936640317108, 12701.814901030424, 12820.679483013, 13943.16341019542, 13976.23130727779, 14127.717445650824, 14148.929255353658, 14169.787453188417, 12061.457234424297, 12253.571125010581, 12379.504819807107, 12438.502459901865, 12463.439145238304, 13282.667933301746, 13337.399817008063, 13364.198148111145, 13386.866131338562, 13441.798373024218, 13174.80237796453, 13196.802047969097, 13275.40260688252, 13277.867221327662, 13299.26854023038, 10442.843357349799, 10560.15518758513, 10687.358758474516, 10748.032677059102, 10931.0, 10497.842532361869, 11087.33475991443, 11105.278156919774, 11131.443427828413, 11218.607348743082], "value": 6763.677789912211, "unit": "score"}], "name": "dromaeo_css", "value": 7180.569071932095, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 112.0, 112.0, 111.0, 111.0, 112.0, 110.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 159.0, 204.0, 125.0, 157.0, 167.0, 125.0, 178.0, 130.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 164.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 159.0, 76.0, 74.0, 76.0, 74.0, 134.0, 77.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 149.0, 92.0, 92.0, 91.0, 135.0, 91.0, 91.0, 123.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 57.0, 57.0, 58.0, 57.0, 110.0, 54.0, 55.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 61.0, 60.0, 61.0, 62.0, 60.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 80.0, 80.0, 83.0, 79.0, 81.0, 84.0, 79.0, 81.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 124.0, 125.0, 137.0, 124.0, 122.0, 121.0, 124.0, 187.0, 124.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 168.0, 167.0, 168.0, 168.0, 167.0, 170.0, 167.0, 168.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1544.2, "alertThreshold": 2.0}]} 01:20:06 INFO - Return code: 0 01:20:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:20:06 ERROR - # TBPL SUCCESS # 01:20:06 INFO - Running post-action listener: _resource_record_post_action 01:20:06 INFO - ##### 01:20:06 INFO - ##### Finished run-tests step (success) 01:20:06 INFO - ##### 01:20:06 INFO - Running post-run listener: _resource_record_post_run 01:20:07 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534003712; Read time: 16; Write time: 411168 01:20:07 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244752384; Read time: 0; Write time: 248308 01:20:07 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289128448; Read time: 16; Write time: 162860 01:20:07 INFO - Running post-run listener: _upload_blobber_files 01:20:07 INFO - Blob upload gear active. 01:20:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:20:07 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 01:20:07 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:20:07 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:20:08 INFO - (blobuploader) - INFO - Open directory for files ... 01:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:20:09 INFO - (blobuploader) - INFO - Done attempting. 01:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:20:09 INFO - (blobuploader) - INFO - Done attempting. 01:20:09 INFO - (blobuploader) - INFO - Iteration through files over. 01:20:09 INFO - Return code: 0 01:20:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:20:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:20:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b67753ae4a96c9cf28df4310fd109b811ee48a788ef6c1c8bbcecef9a72319dd37b02cf5c82a71e37f4cd26743460b5be3bf4c98c2d52021a20686a4eb9d14ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74a9ebb4becd57625455fc2563f9643a28732d6e129843fda32e2418bf5952db3db10f5b2f5bbb301b5b20d9418d50bdb4d2f7bfe4739775d08603a9ff4cc053"} 01:20:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:20:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:20:09 INFO - Contents: 01:20:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b67753ae4a96c9cf28df4310fd109b811ee48a788ef6c1c8bbcecef9a72319dd37b02cf5c82a71e37f4cd26743460b5be3bf4c98c2d52021a20686a4eb9d14ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74a9ebb4becd57625455fc2563f9643a28732d6e129843fda32e2418bf5952db3db10f5b2f5bbb301b5b20d9418d50bdb4d2f7bfe4739775d08603a9ff4cc053"} 01:20:09 INFO - Running post-run listener: copy_logs_to_upload_dir 01:20:09 INFO - Copying logs to upload dir... 01:20:09 INFO - mkdir: /builds/slave/test/build/upload/logs 01:20:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.870314 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-11 01:20:09.772332) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 01:20:09.775872) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622 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-Inbound/sha512/b67753ae4a96c9cf28df4310fd109b811ee48a788ef6c1c8bbcecef9a72319dd37b02cf5c82a71e37f4cd26743460b5be3bf4c98c2d52021a20686a4eb9d14ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74a9ebb4becd57625455fc2563f9643a28732d6e129843fda32e2418bf5952db3db10f5b2f5bbb301b5b20d9418d50bdb4d2f7bfe4739775d08603a9ff4cc053"} build_url:https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/XiPwv6RxTiauPG7Z03rIBQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b67753ae4a96c9cf28df4310fd109b811ee48a788ef6c1c8bbcecef9a72319dd37b02cf5c82a71e37f4cd26743460b5be3bf4c98c2d52021a20686a4eb9d14ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74a9ebb4becd57625455fc2563f9643a28732d6e129843fda32e2418bf5952db3db10f5b2f5bbb301b5b20d9418d50bdb4d2f7bfe4739775d08603a9ff4cc053"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 01:20:09.802956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 01:20:09.803517) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462953398.626201-812345622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004338 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 01:20:09.884606) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 01:20:09.884962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 01:20:09.885291) ========= ========= Total master_lag: 0.17 =========