builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1467601141.47 results: success (0) buildid: 20160703171925 builduid: 9272a0a913a44a7cb598a1f7947d2d6f revision: dbcb78d8ca7469fa8e303eaeeecb17b51757df01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:01.468684) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:01.469128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:01.469403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:01.505451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:01.505734) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-03 19:59:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.1M=0s 2016-07-03 19:59:01 (87.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179476 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:01.716937) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:01.717255) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.105320 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:01.833374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:01.833758) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dbcb78d8ca7469fa8e303eaeeecb17b51757df01 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dbcb78d8ca7469fa8e303eaeeecb17b51757df01 --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=14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-03 19:59:01,912 truncating revision to first 12 chars 2016-07-03 19:59:01,913 Setting DEBUG logging. 2016-07-03 19:59:01,913 attempt 1/10 2016-07-03 19:59:01,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dbcb78d8ca74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 19:59:02,365 unpacking tar archive at: mozilla-beta-dbcb78d8ca74/testing/mozharness/ program finished with exit code 0 elapsedTime=0.784520 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:02.644974) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:02.645392) ========= script_repo_revision: dbcb78d8ca7469fa8e303eaeeecb17b51757df01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:02.645900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:02.646223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 19:59:02.658885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-03 19:59:02.659201) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:59:02 INFO - MultiFileLogger online at 20160703 19:59:02 in /builds/slave/test 19:59:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:59:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:59:02 INFO - {'append_to_log': False, 19:59:02 INFO - 'base_work_dir': '/builds/slave/test', 19:59:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:59:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:59:02 INFO - 'branch': 'Mozilla-Beta', 19:59:02 INFO - 'buildbot_json_path': 'buildprops.json', 19:59:02 INFO - 'config_files': ('talos/linux_config.py',), 19:59:02 INFO - 'default_actions': ('clobber', 19:59:02 INFO - 'read-buildbot-config', 19:59:02 INFO - 'download-and-extract', 19:59:02 INFO - 'populate-webroot', 19:59:02 INFO - 'create-virtualenv', 19:59:02 INFO - 'install', 19:59:02 INFO - 'run-tests'), 19:59:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:59:02 INFO - 'download_minidump_stackwalk': True, 19:59:02 INFO - 'download_symbols': 'ondemand', 19:59:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:59:02 INFO - 'tooltool.py': '/tools/tooltool.py', 19:59:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:59:02 INFO - '/tools/misc-python/virtualenv.py')}, 19:59:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:59:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:59:02 INFO - 'installer_path': 'installer.exe', 19:59:02 INFO - 'log_level': 'info', 19:59:02 INFO - 'log_name': 'talos', 19:59:02 INFO - 'log_to_console': True, 19:59:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:59:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:59:02 INFO - 'opt_config_files': (), 19:59:02 INFO - 'pip_index': False, 19:59:02 INFO - 'sps_profile': False, 19:59:02 INFO - 'sps_profile_interval': 0, 19:59:02 INFO - 'suite': 'dromaeojs', 19:59:02 INFO - 'system_bits': '32', 19:59:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:59:02 INFO - 'title': 'talos-linux64-ix-036', 19:59:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:59:02 INFO - 'use_talos_json': True, 19:59:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:59:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:59:02 INFO - 'work_dir': 'build'} 19:59:02 INFO - ##### 19:59:02 INFO - ##### Running clobber step. 19:59:02 INFO - ##### 19:59:02 INFO - Running pre-action listener: _resource_record_pre_action 19:59:02 INFO - Running main action method: clobber 19:59:02 INFO - rmtree: /builds/slave/test/build 19:59:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:59:04 INFO - Running post-action listener: _resource_record_post_action 19:59:04 INFO - ##### 19:59:04 INFO - ##### Running read-buildbot-config step. 19:59:04 INFO - ##### 19:59:04 INFO - Running pre-action listener: _resource_record_pre_action 19:59:04 INFO - Running main action method: read_buildbot_config 19:59:04 INFO - Using buildbot properties: 19:59:04 INFO - { 19:59:04 INFO - "project": "", 19:59:04 INFO - "product": "firefox", 19:59:04 INFO - "script_repo_revision": "production", 19:59:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 19:59:04 INFO - "repository": "", 19:59:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 19:59:04 INFO - "buildid": "20160703171925", 19:59:04 INFO - "pgo_build": "True", 19:59:04 INFO - "basedir": "/builds/slave/test", 19:59:04 INFO - "buildnumber": 86, 19:59:04 INFO - "slavename": "talos-linux64-ix-036", 19:59:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:59:04 INFO - "platform": "ubuntu64_hw", 19:59:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:59:04 INFO - "branch": "mozilla-beta", 19:59:04 INFO - "repo_path": "releases/mozilla-beta", 19:59:04 INFO - "revision": "dbcb78d8ca7469fa8e303eaeeecb17b51757df01", 19:59:04 INFO - "stage_platform": "linux64-pgo", 19:59:04 INFO - "builduid": "9272a0a913a44a7cb598a1f7947d2d6f", 19:59:04 INFO - "slavebuilddir": "test" 19:59:04 INFO - } 19:59:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 19:59:04 INFO - Running post-action listener: _resource_record_post_action 19:59:04 INFO - ##### 19:59:04 INFO - ##### Running download-and-extract step. 19:59:04 INFO - ##### 19:59:04 INFO - Running pre-action listener: _resource_record_pre_action 19:59:04 INFO - Running main action method: download_and_extract 19:59:04 INFO - mkdir: /builds/slave/test/build/tests 19:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:04 INFO - https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:59:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:59:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:59:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:59:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:59:07 INFO - Downloaded 1327 bytes. 19:59:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:59:07 INFO - Using the following test package requirements: 19:59:07 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 19:59:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:59:07 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:59:07 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:59:07 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 19:59:07 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:59:07 INFO - u'jsshell-linux-x86_64.zip'], 19:59:07 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:59:07 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:59:07 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 19:59:07 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:59:07 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 19:59:07 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:59:07 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 19:59:07 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:59:07 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:59:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:59:07 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:59:07 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:59: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')]} 19:59:07 INFO - https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:59:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:59:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:59:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:59:13 INFO - Downloaded 24235659 bytes. 19:59:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:59:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:59:15 INFO - Return code: 0 19:59:15 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:59:15 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')]} 19:59:15 INFO - https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:59:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:59:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:59:16 INFO - Downloaded 24235659 bytes. 19:59:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:59:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:59:18 INFO - Return code: 0 19:59:18 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')]} 19:59:18 INFO - https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:59:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 19:59:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 19:59:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 19:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:59:20 INFO - Downloaded 10840145 bytes. 19:59:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:59:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:59:20 INFO - Return code: 0 19:59:20 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')]} 19:59:20 INFO - https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:59:22 INFO - Downloaded 56021975 bytes. 19:59:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:59:22 INFO - mkdir: /builds/slave/test/properties 19:59:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:59:22 INFO - Writing to file /builds/slave/test/properties/build_url 19:59:22 INFO - Contents: 19:59:22 INFO - build_url:https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:59:23 INFO - Running post-action listener: _resource_record_post_action 19:59:23 INFO - Running post-action listener: set_extra_try_arguments 19:59:23 INFO - ##### 19:59:23 INFO - ##### Running populate-webroot step. 19:59:23 INFO - ##### 19:59:23 INFO - Running pre-action listener: _resource_record_pre_action 19:59:23 INFO - Running main action method: populate_webroot 19:59:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:23 INFO - '--tppagecycles', 19:59:23 INFO - '7'], 19:59:23 INFO - 'tests': ['tsvgm']}}, 19:59:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:59:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:59:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:59:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:59:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:59:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:23 INFO - 'talos_options': ['--disable-e10s'], 19:59:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:23 INFO - 'talos_options': ['--disable-e10s'], 19:59:23 INFO - 'tests': ['damp', 'tps']}, 19:59:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:23 INFO - 'tests': ['damp', 'tps']}, 19:59:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:59:23 INFO - 'tests': ['dromaeo_dom']}, 19:59:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:59:23 INFO - 'tests': ['a11yr', 19:59:23 INFO - 'ts_paint', 19:59:23 INFO - 'tpaint', 19:59:23 INFO - 'sessionrestore', 19:59:23 INFO - 'sessionrestore_no_auto_restore', 19:59:23 INFO - 'tabpaint']}, 19:59:23 INFO - 'other-e10s': {'tests': ['a11yr', 19:59:23 INFO - 'ts_paint', 19:59:23 INFO - 'tpaint', 19:59:23 INFO - 'sessionrestore', 19:59:23 INFO - 'sessionrestore_no_auto_restore', 19:59:23 INFO - 'tabpaint']}, 19:59:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:59:23 INFO - 'ts_paint', 19:59:23 INFO - 'tpaint', 19:59:23 INFO - 'sessionrestore', 19:59:23 INFO - 'sessionrestore_no_auto_restore', 19:59:23 INFO - 'tabpaint']}, 19:59:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:59:23 INFO - 'ts_paint', 19:59:23 INFO - 'tpaint', 19:59:23 INFO - 'sessionrestore', 19:59:23 INFO - 'sessionrestore_no_auto_restore', 19:59:23 INFO - 'tabpaint']}, 19:59:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:59:23 INFO - 'tests': ['a11yr', 19:59:23 INFO - 'ts_paint', 19:59:23 INFO - 'tpaint', 19:59:23 INFO - 'sessionrestore', 19:59:23 INFO - 'sessionrestore_no_auto_restore', 19:59:23 INFO - 'tabpaint']}, 19:59:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:59:23 INFO - 'tests': ['a11yr', 19:59:23 INFO - 'ts_paint', 19:59:23 INFO - 'tpaint', 19:59:23 INFO - 'sessionrestore', 19:59:23 INFO - 'sessionrestore_no_auto_restore', 19:59:23 INFO - 'tabpaint']}, 19:59:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:59:23 INFO - 'tests': ['tsvgx', 19:59:23 INFO - 'tsvgr_opacity', 19:59:23 INFO - 'tart', 19:59:23 INFO - 'tscrollx', 19:59:23 INFO - 'cart']}, 19:59:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:59:23 INFO - 'tsvgr_opacity', 19:59:23 INFO - 'tart', 19:59:23 INFO - 'tscrollx', 19:59:23 INFO - 'cart']}, 19:59:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:23 INFO - 'talos_options': ['--disable-e10s'], 19:59:23 INFO - 'tests': ['tp5o']}, 19:59:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:23 INFO - 'tests': ['tp5o']}, 19:59:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:23 INFO - 'talos_options': ['--disable-e10s', 19:59:23 INFO - '--xperf_path', 19:59:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:23 INFO - 'tests': ['tp5n']}, 19:59:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:23 INFO - 'talos_options': ['--xperf_path', 19:59:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:23 INFO - 'tests': ['tp5n']}}, 19:59:23 INFO - 'talos.zip': {'path': '', 19:59:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:23 INFO - Running post-action listener: _resource_record_post_action 19:59:23 INFO - ##### 19:59:23 INFO - ##### Running create-virtualenv step. 19:59:23 INFO - ##### 19:59:23 INFO - Running pre-action listener: _resource_record_pre_action 19:59:23 INFO - Running main action method: create_virtualenv 19:59:23 INFO - Creating virtualenv /builds/slave/test/build/venv 19:59:23 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 19:59:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:59:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:25 INFO - Using real prefix '/usr' 19:59:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:59:25 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:27 INFO - Installing pip.................done. 19:59:27 INFO - Return code: 0 19:59:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:27 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 0x7ffd78a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eb410>, '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 0x22ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', '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 19:59:27 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 19:59:27 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 19:59:27 INFO - Using env: {'DISPLAY': ':0', 19:59:27 INFO - 'HOME': '/home/cltbld', 19:59:27 INFO - 'LANG': 'en_US.UTF-8', 19:59:27 INFO - 'LANGUAGE': 'en_US:en', 19:59:27 INFO - 'LOGNAME': 'cltbld', 19:59:27 INFO - 'MAIL': '/var/mail/cltbld', 19:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:27 INFO - 'MOZ_NO_REMOTE': '1', 19:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:27 INFO - 'NO_EM_RESTART': '1', 19:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:27 INFO - 'PWD': '/builds/slave/test', 19:59:27 INFO - 'SHELL': '/bin/bash', 19:59:27 INFO - 'SHLVL': '1', 19:59:27 INFO - 'TERM': 'linux', 19:59:27 INFO - 'TMOUT': '86400', 19:59:27 INFO - 'USER': 'cltbld', 19:59:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', 19:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:27 INFO - '_': '/tools/buildbot/bin/python'} 19:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:28 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 19:59:28 INFO - Cleaning up... 19:59:28 INFO - Return code: 0 19:59:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:28 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 0x7ffd78a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eb410>, '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 0x22ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', '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 19:59:28 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 19:59:28 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 19:59:28 INFO - Using env: {'DISPLAY': ':0', 19:59:28 INFO - 'HOME': '/home/cltbld', 19:59:28 INFO - 'LANG': 'en_US.UTF-8', 19:59:28 INFO - 'LANGUAGE': 'en_US:en', 19:59:28 INFO - 'LOGNAME': 'cltbld', 19:59:28 INFO - 'MAIL': '/var/mail/cltbld', 19:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:28 INFO - 'MOZ_NO_REMOTE': '1', 19:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:28 INFO - 'NO_EM_RESTART': '1', 19:59:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:28 INFO - 'PWD': '/builds/slave/test', 19:59:28 INFO - 'SHELL': '/bin/bash', 19:59:28 INFO - 'SHLVL': '1', 19:59:28 INFO - 'TERM': 'linux', 19:59:28 INFO - 'TMOUT': '86400', 19:59:28 INFO - 'USER': 'cltbld', 19:59:28 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', 19:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:28 INFO - '_': '/tools/buildbot/bin/python'} 19:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:28 INFO - Downloading/unpacking psutil>=0.7.1 19:59:28 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 19:59:28 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 19:59:28 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 19:59:28 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 19:59:28 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 19:59:28 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 19:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:30 INFO - Installing collected packages: psutil 19:59:30 INFO - Running setup.py install for psutil 19:59:30 INFO - building 'psutil._psutil_linux' extension 19:59:30 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 19:59:31 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 19:59:31 INFO - building 'psutil._psutil_posix' extension 19:59:31 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 19:59:31 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 19:59:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:32 INFO - Successfully installed psutil 19:59:32 INFO - Cleaning up... 19:59:32 INFO - Return code: 0 19:59:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:32 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 0x7ffd78a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eb410>, '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 0x22ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', '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 19:59:32 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 19:59:32 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 19:59:32 INFO - Using env: {'DISPLAY': ':0', 19:59:32 INFO - 'HOME': '/home/cltbld', 19:59:32 INFO - 'LANG': 'en_US.UTF-8', 19:59:32 INFO - 'LANGUAGE': 'en_US:en', 19:59:32 INFO - 'LOGNAME': 'cltbld', 19:59:32 INFO - 'MAIL': '/var/mail/cltbld', 19:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:32 INFO - 'MOZ_NO_REMOTE': '1', 19:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:32 INFO - 'NO_EM_RESTART': '1', 19:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:32 INFO - 'PWD': '/builds/slave/test', 19:59:32 INFO - 'SHELL': '/bin/bash', 19:59:32 INFO - 'SHLVL': '1', 19:59:32 INFO - 'TERM': 'linux', 19:59:32 INFO - 'TMOUT': '86400', 19:59:32 INFO - 'USER': 'cltbld', 19:59:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', 19:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:32 INFO - '_': '/tools/buildbot/bin/python'} 19:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:59:32 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 19:59:32 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 19:59:32 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 19:59:32 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 19:59:32 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 19:59:32 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 19:59:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:59:34 INFO - Installing collected packages: mozsystemmonitor 19:59:34 INFO - Running setup.py install for mozsystemmonitor 19:59:34 INFO - Successfully installed mozsystemmonitor 19:59:34 INFO - Cleaning up... 19:59:34 INFO - Return code: 0 19:59:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19: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')]} 19:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19: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')]} 19:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffd78a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eb410>, '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 0x22ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', '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 19:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:59:34 INFO - Using env: {'DISPLAY': ':0', 19:59:34 INFO - 'HOME': '/home/cltbld', 19:59:34 INFO - 'LANG': 'en_US.UTF-8', 19:59:34 INFO - 'LANGUAGE': 'en_US:en', 19:59:34 INFO - 'LOGNAME': 'cltbld', 19:59:34 INFO - 'MAIL': '/var/mail/cltbld', 19:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:34 INFO - 'MOZ_NO_REMOTE': '1', 19:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:34 INFO - 'NO_EM_RESTART': '1', 19:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:34 INFO - 'PWD': '/builds/slave/test', 19:59:34 INFO - 'SHELL': '/bin/bash', 19:59:34 INFO - 'SHLVL': '1', 19:59:34 INFO - 'TERM': 'linux', 19:59:34 INFO - 'TMOUT': '86400', 19:59:34 INFO - 'USER': 'cltbld', 19:59:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', 19:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:34 INFO - '_': '/tools/buildbot/bin/python'} 19:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:34 INFO - Downloading/unpacking blobuploader==1.2.4 19:59:34 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 19:59:34 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 19:59:34 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 19:59:34 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 19:59:34 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 19:59:34 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 19:59:36 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59:36 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 19:59:36 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 19:59:36 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 19:59:36 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 19:59:36 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 19:59:36 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 19:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:59:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:37 INFO - Downloading docopt-0.6.1.tar.gz 19:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:37 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:37 INFO - Running setup.py install for blobuploader 19:59:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:59:37 INFO - Running setup.py install for requests 19:59:37 INFO - Running setup.py install for docopt 19:59:37 INFO - Successfully installed blobuploader requests docopt 19:59:37 INFO - Cleaning up... 19:59:37 INFO - Return code: 0 19:59:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:37 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 0x7ffd78a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eb410>, '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 0x22ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', '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 19:59:37 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 19:59:37 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 19:59:37 INFO - Using env: {'DISPLAY': ':0', 19:59:37 INFO - 'HOME': '/home/cltbld', 19:59:37 INFO - 'LANG': 'en_US.UTF-8', 19:59:37 INFO - 'LANGUAGE': 'en_US:en', 19:59:37 INFO - 'LOGNAME': 'cltbld', 19:59:37 INFO - 'MAIL': '/var/mail/cltbld', 19:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:37 INFO - 'MOZ_NO_REMOTE': '1', 19:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:37 INFO - 'NO_EM_RESTART': '1', 19:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:37 INFO - 'PWD': '/builds/slave/test', 19:59:37 INFO - 'SHELL': '/bin/bash', 19:59:37 INFO - 'SHLVL': '1', 19:59:37 INFO - 'TERM': 'linux', 19:59:37 INFO - 'TMOUT': '86400', 19:59:37 INFO - 'USER': 'cltbld', 19:59:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', 19:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:37 INFO - '_': '/tools/buildbot/bin/python'} 19:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:38 INFO - Running setup.py (path:/tmp/pip-OChsjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:38 INFO - Running setup.py (path:/tmp/pip-_w3xig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:38 INFO - Running setup.py (path:/tmp/pip-D4obWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:38 INFO - Running setup.py (path:/tmp/pip-2fdizh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:38 INFO - Running setup.py (path:/tmp/pip-0DbTHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:38 INFO - Running setup.py (path:/tmp/pip-lKS9Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:38 INFO - Running setup.py (path:/tmp/pip-VwC3sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:38 INFO - Running setup.py (path:/tmp/pip-lMPYjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:38 INFO - Running setup.py (path:/tmp/pip-56r7pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:38 INFO - Running setup.py (path:/tmp/pip-6IJwTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:38 INFO - Running setup.py (path:/tmp/pip-Kb923F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:38 INFO - Running setup.py (path:/tmp/pip-vGavoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:39 INFO - Running setup.py (path:/tmp/pip-g6XT36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:39 INFO - Running setup.py (path:/tmp/pip-cmEtvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:39 INFO - Running setup.py (path:/tmp/pip-ip4q6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:39 INFO - Running setup.py (path:/tmp/pip-PCtWNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:59:39 INFO - Running setup.py (path:/tmp/pip-FUvZoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:59:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:39 INFO - Running setup.py install for manifestparser 19:59:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:59:39 INFO - Running setup.py install for mozcrash 19:59:39 INFO - Running setup.py install for mozdebug 19:59:39 INFO - Running setup.py install for mozdevice 19:59:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:59:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:59:39 INFO - Running setup.py install for mozfile 19:59:39 INFO - Running setup.py install for mozhttpd 19:59:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Running setup.py install for mozinfo 19:59:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Running setup.py install for mozInstall 19:59:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Running setup.py install for mozleak 19:59:40 INFO - Running setup.py install for mozlog 19:59:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Running setup.py install for moznetwork 19:59:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Running setup.py install for mozprocess 19:59:40 INFO - Running setup.py install for mozprofile 19:59:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Running setup.py install for mozrunner 19:59:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:59:40 INFO - Running setup.py install for mozscreenshot 19:59:40 INFO - Running setup.py install for moztest 19:59:41 INFO - Running setup.py install for mozversion 19:59:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:59:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:41 INFO - Cleaning up... 19:59:41 INFO - Return code: 0 19:59:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:41 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 0x7ffd78a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eb410>, '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 0x22ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', '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 19:59:41 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 19:59:41 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 19:59:41 INFO - Using env: {'DISPLAY': ':0', 19:59:41 INFO - 'HOME': '/home/cltbld', 19:59:41 INFO - 'LANG': 'en_US.UTF-8', 19:59:41 INFO - 'LANGUAGE': 'en_US:en', 19:59:41 INFO - 'LOGNAME': 'cltbld', 19:59:41 INFO - 'MAIL': '/var/mail/cltbld', 19:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:41 INFO - 'MOZ_NO_REMOTE': '1', 19:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:41 INFO - 'NO_EM_RESTART': '1', 19:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:41 INFO - 'PWD': '/builds/slave/test', 19:59:41 INFO - 'SHELL': '/bin/bash', 19:59:41 INFO - 'SHLVL': '1', 19:59:41 INFO - 'TERM': 'linux', 19:59:41 INFO - 'TMOUT': '86400', 19:59:41 INFO - 'USER': 'cltbld', 19:59:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', 19:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:41 INFO - '_': '/tools/buildbot/bin/python'} 19:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:41 INFO - Running setup.py (path:/tmp/pip-zbpCy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:41 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)) 19:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:41 INFO - Running setup.py (path:/tmp/pip-4HijnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:41 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)) 19:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:41 INFO - Running setup.py (path:/tmp/pip-jOBPV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:41 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)) 19:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:41 INFO - Running setup.py (path:/tmp/pip-zIHHbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:41 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)) 19:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:41 INFO - Running setup.py (path:/tmp/pip-hl6Npn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:41 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)) 19:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:41 INFO - Running setup.py (path:/tmp/pip-Jz1CAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:41 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)) 19:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:41 INFO - Running setup.py (path:/tmp/pip-BGs0wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:41 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)) 19:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:41 INFO - Running setup.py (path:/tmp/pip-fLgzR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:41 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)) 19:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:41 INFO - Running setup.py (path:/tmp/pip-GEIcuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:42 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)) 19:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:42 INFO - Running setup.py (path:/tmp/pip-rWqrIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:42 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)) 19:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:42 INFO - Running setup.py (path:/tmp/pip-MFNv0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:42 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)) 19:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:42 INFO - Running setup.py (path:/tmp/pip-5UIM5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:42 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)) 19:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:42 INFO - Running setup.py (path:/tmp/pip-dl2Fl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:42 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)) 19:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:42 INFO - Running setup.py (path:/tmp/pip-JeADNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:42 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)) 19:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:42 INFO - Running setup.py (path:/tmp/pip-RkjlFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:42 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)) 19:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:42 INFO - Running setup.py (path:/tmp/pip-NaHvda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:59:42 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)) 19:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:59:42 INFO - Running setup.py (path:/tmp/pip-V0m40Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:59:42 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)) 19:59:42 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)) 19:59:42 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)) 19:59:42 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)) 19:59:42 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)) 19:59:42 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)) 19:59:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:44 INFO - Downloading blessings-1.6.tar.gz 19:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:59:44 INFO - Installing collected packages: blessings 19:59:44 INFO - Running setup.py install for blessings 19:59:44 INFO - Successfully installed blessings 19:59:44 INFO - Cleaning up... 19:59:44 INFO - Return code: 0 19:59:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:59:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:59:44 INFO - Reading from file tmpfile_stdout 19:59:44 INFO - Current package versions: 19:59:44 INFO - argparse == 1.2.1 19:59:44 INFO - blessings == 1.6 19:59:44 INFO - blobuploader == 1.2.4 19:59:44 INFO - docopt == 0.6.1 19:59:44 INFO - manifestparser == 1.1 19:59:44 INFO - mozInstall == 1.12 19:59:44 INFO - mozcrash == 0.17 19:59:44 INFO - mozdebug == 0.1 19:59:44 INFO - mozdevice == 0.48 19:59:44 INFO - mozfile == 1.2 19:59:44 INFO - mozhttpd == 0.7 19:59:44 INFO - mozinfo == 0.9 19:59:44 INFO - mozleak == 0.1 19:59:44 INFO - mozlog == 3.1 19:59:44 INFO - moznetwork == 0.27 19:59:44 INFO - mozprocess == 0.22 19:59:44 INFO - mozprofile == 0.28 19:59:44 INFO - mozrunner == 6.11 19:59:44 INFO - mozscreenshot == 0.1 19:59:44 INFO - mozsystemmonitor == 0.0 19:59:44 INFO - moztest == 0.7 19:59:44 INFO - mozversion == 1.4 19:59:44 INFO - psutil == 3.1.1 19:59:44 INFO - requests == 1.2.3 19:59:44 INFO - wsgiref == 0.1.2 19:59:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19: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')]} 19:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19: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')]} 19:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:44 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 0x7ffd78a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eb410>, '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 0x22ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', '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 19:59:44 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 19:59:44 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 19:59:44 INFO - Using env: {'DISPLAY': ':0', 19:59:44 INFO - 'HOME': '/home/cltbld', 19:59:44 INFO - 'LANG': 'en_US.UTF-8', 19:59:44 INFO - 'LANGUAGE': 'en_US:en', 19:59:44 INFO - 'LOGNAME': 'cltbld', 19:59:44 INFO - 'MAIL': '/var/mail/cltbld', 19:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:44 INFO - 'MOZ_NO_REMOTE': '1', 19:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:44 INFO - 'NO_EM_RESTART': '1', 19:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:44 INFO - 'PWD': '/builds/slave/test', 19:59:44 INFO - 'SHELL': '/bin/bash', 19:59:44 INFO - 'SHLVL': '1', 19:59:44 INFO - 'TERM': 'linux', 19:59:44 INFO - 'TMOUT': '86400', 19:59:44 INFO - 'USER': 'cltbld', 19:59:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', 19:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:44 INFO - '_': '/tools/buildbot/bin/python'} 19:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:45 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)) 19:59:45 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)) 19:59:45 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)) 19:59:45 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)) 19:59:45 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)) 19:59:45 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)) 19:59:45 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)) 19:59:45 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)) 19:59:45 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)) 19:59:45 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)) 19:59:45 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)) 19:59:45 INFO - Cleaning up... 19:59:45 INFO - Return code: 0 19:59:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:45 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 0x7ffd78a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eb410>, '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 0x22ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', '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 19:59:45 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 19:59:45 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 19:59:45 INFO - Using env: {'DISPLAY': ':0', 19:59:45 INFO - 'HOME': '/home/cltbld', 19:59:45 INFO - 'LANG': 'en_US.UTF-8', 19:59:45 INFO - 'LANGUAGE': 'en_US:en', 19:59:45 INFO - 'LOGNAME': 'cltbld', 19:59:45 INFO - 'MAIL': '/var/mail/cltbld', 19:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:45 INFO - 'MOZ_NO_REMOTE': '1', 19:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:45 INFO - 'NO_EM_RESTART': '1', 19:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:45 INFO - 'PWD': '/builds/slave/test', 19:59:45 INFO - 'SHELL': '/bin/bash', 19:59:45 INFO - 'SHLVL': '1', 19:59:45 INFO - 'TERM': 'linux', 19:59:45 INFO - 'TMOUT': '86400', 19:59:45 INFO - 'USER': 'cltbld', 19:59:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', 19:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:45 INFO - '_': '/tools/buildbot/bin/python'} 19:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:45 INFO - Downloading/unpacking jsonschema 19:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:47 INFO - Downloading/unpacking functools32 (from jsonschema) 19:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:47 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:47 INFO - warning: no files found matching '*.txt' 19:59:47 INFO - no previously-included directories found matching 'build' 19:59:47 INFO - no previously-included directories found matching 'dist' 19:59:47 INFO - no previously-included directories found matching '.git*' 19:59:47 INFO - Installing collected packages: jsonschema, functools32 19:59:47 INFO - Running setup.py install for functools32 19:59:47 INFO - warning: no files found matching '*.txt' 19:59:47 INFO - no previously-included directories found matching 'build' 19:59:47 INFO - no previously-included directories found matching 'dist' 19:59:47 INFO - no previously-included directories found matching '.git*' 19:59:47 INFO - Successfully installed jsonschema functools32 19:59:47 INFO - Cleaning up... 19:59:47 INFO - Return code: 0 19:59:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd78a71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eb410>, '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 0x22ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', '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 19:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:59:47 INFO - Using env: {'DISPLAY': ':0', 19:59:47 INFO - 'HOME': '/home/cltbld', 19:59:47 INFO - 'LANG': 'en_US.UTF-8', 19:59:47 INFO - 'LANGUAGE': 'en_US:en', 19:59:47 INFO - 'LOGNAME': 'cltbld', 19:59:47 INFO - 'MAIL': '/var/mail/cltbld', 19:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:47 INFO - 'MOZ_NO_REMOTE': '1', 19:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:47 INFO - 'NO_EM_RESTART': '1', 19:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:47 INFO - 'PWD': '/builds/slave/test', 19:59:47 INFO - 'SHELL': '/bin/bash', 19:59:47 INFO - 'SHLVL': '1', 19:59:47 INFO - 'TERM': 'linux', 19:59:47 INFO - 'TMOUT': '86400', 19:59:47 INFO - 'USER': 'cltbld', 19:59:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', 19:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:47 INFO - '_': '/tools/buildbot/bin/python'} 19:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:48 INFO - Downloading/unpacking flake8 19:59:48 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 19:59:48 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 19:59:48 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 19:59:48 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 19:59:48 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 19:59:48 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 19:59:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:59:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:59:49 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 19:59:49 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 19:59:49 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 19:59:49 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 19:59:49 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 19:59:49 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 19:59:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:59:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:59:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:50 INFO - no previously-included directories found matching 'docs/_build' 19:59:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:59:50 INFO - Running setup.py install for pep8 19:59:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:50 INFO - no previously-included directories found matching 'docs/_build' 19:59:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:59:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:59:51 INFO - Cleaning up... 19:59:51 INFO - Return code: 0 19:59:51 INFO - Running post-action listener: _resource_record_post_action 19:59:51 INFO - Running post-action listener: _start_resource_monitoring 19:59:51 INFO - Starting resource monitoring. 19:59:51 INFO - ##### 19:59:51 INFO - ##### Running install step. 19:59:51 INFO - ##### 19:59:51 INFO - Running pre-action listener: _resource_record_pre_action 19:59:51 INFO - Running main action method: install 19:59:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:59:51 INFO - Reading from file tmpfile_stdout 19:59:51 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:59:51 INFO - Reading from file tmpfile_stdout 19:59:51 INFO - Output received: 19:59:51 INFO - Usage: mozinstall [options] installer 19:59:51 INFO - Options: 19:59:51 INFO - -h, --help show this help message and exit 19:59:51 INFO - -d DEST, --destination=DEST 19:59:51 INFO - Directory to install application into. [default: 19:59:51 INFO - "/builds/slave/test"] 19:59:51 INFO - --app=APP Application being installed. [default: firefox] 19:59:51 INFO - mkdir: /builds/slave/test/build/application 19:59:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:00:04 INFO - Reading from file tmpfile_stdout 20:00:04 INFO - Output received: 20:00:04 INFO - /builds/slave/test/build/application/firefox/firefox 20:00:04 INFO - Running post-action listener: _resource_record_post_action 20:00:04 INFO - ##### 20:00:04 INFO - ##### Running run-tests step. 20:00:04 INFO - ##### 20:00:04 INFO - Running pre-action listener: _resource_record_pre_action 20:00:04 INFO - Running main action method: run_tests 20:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:00:04 INFO - Python 2.7.3 20:00:04 INFO - Return code: 0 20:00:04 INFO - grabbing minidump binary from tooltool 20:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eb410>, '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 0x22ec310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ec7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:00:04 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 20:00:04 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 20:00:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:00:04 INFO - Return code: 0 20:00:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:00:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:00:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:00:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:00:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:00:05 INFO - Return code: 0 20:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 20:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 20:00:05 INFO - Using env: {'DISPLAY': ':0', 20:00:05 INFO - 'HOME': '/home/cltbld', 20:00:05 INFO - 'LANG': 'en_US.UTF-8', 20:00:05 INFO - 'LANGUAGE': 'en_US:en', 20:00:05 INFO - 'LOGNAME': 'cltbld', 20:00:05 INFO - 'MAIL': '/var/mail/cltbld', 20:00:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:00:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:05 INFO - 'MOZ_NO_REMOTE': '1', 20:00:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:05 INFO - 'NO_EM_RESTART': '1', 20:00:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:05 INFO - 'PWD': '/builds/slave/test', 20:00:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:00:05 INFO - 'SHELL': '/bin/bash', 20:00:05 INFO - 'SHLVL': '1', 20:00:05 INFO - 'TERM': 'linux', 20:00:05 INFO - 'TMOUT': '86400', 20:00:05 INFO - 'USER': 'cltbld', 20:00:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725', 20:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:05 INFO - '_': '/tools/buildbot/bin/python'} 20:00:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 20:00:05 INFO - mozversion application_buildid: 20160703171925 20:00:05 INFO - mozversion application_changeset: dbcb78d8ca7469fa8e303eaeeecb17b51757df01 20:00:05 INFO - mozversion application_display_name: Firefox 20:00:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:00:05 INFO - mozversion application_name: Firefox 20:00:05 INFO - mozversion application_remotingname: firefox 20:00:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:00:05 INFO - mozversion application_vendor: Mozilla 20:00:05 INFO - mozversion application_version: 48.0 20:00:05 INFO - mozversion platform_buildid: 20160703171925 20:00:05 INFO - mozversion platform_changeset: dbcb78d8ca7469fa8e303eaeeecb17b51757df01 20:00:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:00:05 INFO - mozversion platform_version: 48.0 20:00:05 INFO - using testdate: 1467601205 20:00:05 INFO - actual date: 1467601205 20:00:05 INFO - starting webserver on 'localhost:52773' 20:00:05 INFO - SUITE-START | Running 2 tests 20:00:05 INFO - TEST-START | dromaeo_css 20:00:05 INFO - operating with platform_type : linux_ 20:00:05 INFO - Initialising browser for dromaeo_css test... 20:00:05 INFO - TEST-INFO | started process 3318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeX8ZPD/profile http://localhost:52773/getInfo.html) 20:00:10 INFO - PROCESS | 3318 | __metrics Screen width/height:1600/1200 20:00:10 INFO - PROCESS | 3318 | colorDepth:24 20:00:10 INFO - PROCESS | 3318 | Browser inner width/height: 1024/697 20:00:10 INFO - PROCESS | 3318 | __metrics 20:00:11 ERROR - PROCESS | 3318 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:00:12 INFO - TEST-INFO | 3318: exit 0 20:00:12 INFO - Browser initialized. 20:00:12 INFO - Running cycle 1/1 for dromaeo_css test... 20:00:12 INFO - TEST-INFO | started process 3408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeX8ZPD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:24 INFO - PROCESS | 3408 | RSS: Main: 139669504 20:00:24 INFO - PROCESS | 3408 | 20:01:15 INFO - PROCESS | 3408 | 1467601275483 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] 20:03:23 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52773/tests/dromaeo/cssquery-ext.html) 20:03:24 INFO - PROCESS | 3408 | RSS: Main: 250212352 20:03:24 INFO - PROCESS | 3408 | 20:06:26 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-ext.html (next: http://localhost:52773/tests/dromaeo/cssquery-jquery.html) 20:06:27 INFO - PROCESS | 3408 | RSS: Main: 223506432 20:06:27 INFO - PROCESS | 3408 | 20:09:28 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52773/tests/dromaeo/cssquery-mootools.html) 20:09:29 INFO - PROCESS | 3408 | RSS: Main: 222855168 20:09:29 INFO - PROCESS | 3408 | 20:12:31 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52773/tests/dromaeo/cssquery-prototype.html) 20:12:31 INFO - PROCESS | 3408 | RSS: Main: 213356544 20:12:31 INFO - PROCESS | 3408 | 20:15:34 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52773/tests/dromaeo/cssquery-yui.html) 20:15:34 INFO - PROCESS | 3408 | RSS: Main: 212570112 20:15:34 INFO - PROCESS | 3408 | 20:18:37 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:52773/tests/dromaeo/cssquery-yui.html (next: http://localhost:52773/tests/dromaeo/cssquery-dojo.html) 20:18:37 INFO - PROCESS | 3408 | RSS: Main: 278974464 20:18:37 INFO - PROCESS | 3408 | 20:18:37 INFO - PROCESS | 3408 | __start_tp_report 20:18:37 INFO - PROCESS | 3408 | _x_x_mozilla_page_load 20:18:37 INFO - PROCESS | 3408 | _x_x_mozilla_page_load_details 20:18:37 INFO - PROCESS | 3408 | |i|pagename|runs| 20:18:37 INFO - PROCESS | 3408 | |0;dojo.html;3293.1437826165193;3340.2150494633765;3365.89902302931;3394.0666316762904;3412.4881267809824;5562.221289019535;5569.610127291091;5571.637843540167;5587.497125258726;5590.86022849429;5534.833954981347;5549.722513874311;5555.555555555556;5586.190002449643;5603.887922241553;4993.950060499403;5015.598752099832;5049.444561098277;5104.0812653722505;5149.407818100929;5004.524570165829;5086.41506226785;5089.465606111342;5093.185090385539;5094.6433749637545;5021.573166280852;5072.9746351268195;5135.691858488484;5157.123289040872;5180.378354597454;5027.698338099707;5032.798688052473;5035.62232832539;5047.167217409123;5062.493750624926;4936.728479933602;4962;4967.826126085606;5065.645404821664;5145.536901678867;5464.508194262536;5473.808416705396;5512.972435137839;5531.419200983879;5534.667919924817;5969.70151492428;5983.252093488314;6000.609960352563;6003.879922401527;6004.669743164124;6035.39646035393;6056.4851987581105;6095.238095238095;6111.174991376151;6154.938450615481;5483.698396588186;5535.086710692731;5535.363433205192;5539.335279766454;5553.4724201200825;5868.295804503401;6017.187679663277;6024.036154215304;6025.517958563304;6028.5478589106;5748.166515855178;5831.067029275296;5836.9124463133085;5837.562182836305;5839.941600583939;5966.463018328372;5967.462928336384;5971.731272092767;5976.402359763989;5977.850553736104;5819.476247137778;5862.882742345129;5913.349531551526;5918.378570250148;5923.674197919069;5924.437178468039;5965.642061476238;5969.253843269591;5973.790917317873;6006.729697163551;4556.066006468666;4563.155816174019;4563.520830312836;4570.565796249351;4591.4260717410325;3993.6405723485027;4011.3180759270995;4069.2268468990796;4088.8568900088353;4131.586841315904;5572.4706152916215;5586.050371436865;5600.943990560124;5602.971985140048;5628.60599758013;5921.259842519685;5931.6441013539325;5932.762689492372;5933.762649494059;5942.554308426799;5546.944530554723;5606.775728970877;5617.466340697627;5681.488666020078;5684;5118.897622047538;5142.125838607446;5145.614078944094;5145.665531740425;5147.459516750762;6241.251049874044;6259.7496100156395;6262.060690896311;6263.874722505524;6264.5301602379095;5926.762929482945;5950.970245148833;6043.516518678583;6049.062395328731;6054.636721796706;6142.871395789577;6173.197484327009;6183.288921773874;6187.690615469119;6188.040853667689;5816.47651711348;5819.330776960704;5826.650400975955;5831.79588714393;5866.882662346815;5869.970650146722;5983.252093488314;6059.697015149313;6067.605605635619;6083.939160608337;5832.854178645568;5847.766089356548;5872.29532456108;5876.676782776988;5892.175095486721;5738.426157384228;5803.883922321615;5891.469767720926;5900.409959004065;5913.556483263858;5733.283339582552;5795.39148389413;5797.362290148165;5798.1302804579655;5839.270091238595;5864.44287792659;5866.50134738552;5867.559933004956;5870.647761134345;5874.148248504029;5564.443555644403;5624.915626265528;5748.338941021836;5755.53955683536;5776.046952252831 20:18:37 INFO - PROCESS | 3408 | |1;ext.html;667.3326673326674;668.1080757189152;672.0456951129397;682.9346219896961;740.7185269597555;33463.16342091449;34155.316893662144;41048.384274235876;41557.16885662285;41668;44586;45121.09757804842;45210.54789452104;45276;45280.0943981121;8045.678172873078;8725.34559908008;8892.59983300753;8908.465492070463;8908.73273801787;10656.200784941122;10961.232713710044;10971.177161712863;10975.231733778639;10976.725581860477;10518.684439466828;10610.098141657969;10614.460903169036;10616.946915265413;10624.681259562225;10326.070653641209;10336.689899303034;10340.327878687936;10364.32631878933;10411.479426028705;10332.431716255604;10433.895661043369;10449.164066874631;10483.10893574047;10484.161267098614;44489.33266001013;45272.77363613194;45294.547054529365;45308;45362.54637453616;3834.559025712051;3855.8843234703004;3897.0452239201577;4106.425100485934;4419.712718673276;34370;34383.656163438296;34522.48216276758;34551.4817277741;34856.82571587151;4598.448186217642;4621.838235661769;4668.789904454274;4677.719336839767;4685.367475390813;317358;317896;319667;319976;320124;65052;65367.67316163389;65671.34328656652;65760.67119664371;65863;64007.35992640107;64337.67831160814;71605.64197179084;72592.63703681447;72726.63636681889;17483.213255403538;17596.648067038586;17623.735643965094;17659.11704414774;17660.823391766175;13977.650558736113;14263.78604320936;14392.712145757236;14636.926815365856;14657.486987955584;19997.400077997685;20074;20275.188992440137;20327.085281162384;20347.389578312675;7312.1956584775635;7624.504407213513;7666.3866890648615;7667.501612395288;7762.301392874669;1120.6638008597552;1147.718808891827;1150.2121047082776;1162.1092780023546;1233.3894722112611;34331.31337373239;34580.82709586436;35231.11922201965;35487.29025419477;35813.64186358103;1233.9568115115928;1271.8124825300467;1279.500994612102;1325.2644782145808;1343.9260840653858;17581.384651537133;18237.08814559267;18501.90749046246;18726.53183670419;18817.341393051178;449483;455213;456025;456990;457497;52686.736566316926;53032;53049.2042619361;53106;53268;1494.9626259343386;1517.681286929757;1529.342382775395;1533.2410456823943;1587.4443944619522;33566.49650255199;33958;34314.65685343214;34395.484067739504;34751.47872781961;52178.73910630422;52726.681832954484;52782.20826687526;52783.736081319345;52836;282412;289198;289855;290991;410992;31364.529532057495;31840.840795795873;32109.678903210668;32370.190745230615;32378.514322285657;46569.3014604788;46951.29573056475;47176.29235561538;47857;47941.5205847937;39834;42026.369604456566;43013.56986430095;43042;44252.11495770131;40953.385699215134;41562;41860.79069604632;42008.1598368037;43312.350314744675;43926;43959.78020109879;44432.33351499665;47373.763131184125;48395.75802121108;34884.476732849536;38746.41880371853;39082.413763792996;40718.79640601896;44048.55951440445;29330.09354391958;29341.559876602296;29407.264818378855;29475.410491790473;29540.704592954655 20:18:37 INFO - PROCESS | 3408 | |2;jquery.html;432.9437173167488;435.52092698032186;438.4198988950028;447.8745951133683;450.1739308369142;18596.721049184256;19084.141213645384;19169.808301916975;19905.800941990576;20191.59616807663;19078.713819292687;19376.321828735996;20005.899970500126;20026;20029.899850500762;5712.771489140429;5802.738876750556;5951.404859514036;5956.583039187259;5963.284405871302;4275.636570891478;5865.970670146665;5883.088121341178;6140.201773769404;6443.29123796382;6391.073294372313;6407.487401007908;6410;6419.069234960928;6420.678966051702;5741.167530708045;6005.159277701126;6016.127661489059;6016.187814645011;6353.459955903731;3985.322495175798;5589.189567512729;5833.620814647034;5840.853978650525;5855.4144585541535;14108.294585270798;14190.787138192833;14343.282835858165;14343.713125737428;14400.63998400038;2471.95056098877;2547.172169045049;2593.5590949538623;2626.2515183172704;2650.615660729203;10995.065419439357;11064.114870810316;11111.499982500807;11122.332660040423;12908.741825163537;2012.788657191003;2025.3012710614814;2036.908339124743;2075.6575165097893;2150.849440539163;78735;83405.99999999939;86703.56648216782;86782.13217867803;87444;11401.258918170459;11532.308061516336;11647.41762911868;11754.29474231549;11953.940230298967;16762;16870.831291687173;16888.662226755398;16918.407855724992;16935.745963810554;8671.609777560025;8794.120587941155;8826.823463530693;9019.729408117766;9020.503872286956;8678.39251252419;8753.868691969625;8847.02682704902;8931.285497160212;8940.68707595231;5085.1355269604255;5179.48205179479;5180.870478238075;5186.766595503212;5212.3223980883;1884.575970406675;2032.9593408131755;2078.8233000195155;2086.8747875127237;2101.443117573844;1013.8225810483136;1036.3781730961364;1059.9470026498643;1066.9306495077794;1103.3269705479652;18291.085445727662;18310.908445457953;18492.35276765307;19601.411957641292;20169.39491815248;1067.69570672358;1095.6439157273917;1123.43828085957;1125.634168895096;1135.5117299561102;10876.61931832398;11230.494627741771;11231.55073797039;11247.775044499063;11274.492647830868;510188;516139;526910;527390;530043;97797;99984.50007749915;101009;101041.49479252557;101235;1096.3750662122673;1121.0695123047851;1123.2811000959393;1142.8000099982469;1145.1583086431467;17045.318187272867;17358.652826943642;17450;17526.298948041935;17683.79052369077;40369.798151009054;40710.59289407068;40900.18199635931;41496.377554336104;42588;58542;58929;59113.11330329962;59425;59484.70257648684;8652.524111173945;8658.740237792876;8670;8927.464352138892;8928.598213080297;11040.503177356877;13590.252536110609;13612.727745445234;13651.863481365059;13788.448462061806;11786.46960886745;12041.518339266331;12142.453589588313;12253.754924901274;12254.571090011807;11633.185677002528;11745.001674857733;11854.881451185378;11903.226290291102;12193.146479746332;11218.943905280421;11972.820407693718;12020.398980050788;12193.69515762113;12361.724143102265;9062.818743625223;9117.863232051392;9137.223336016514;9256.166944974715;9455.338126331091;9547.618095276111;12550;12607.810882836948;12613;12622.11645184865 20:18:37 INFO - PROCESS | 3408 | |3;mootools.html;1484.8440913704053;1599.6240883392402;1611.9435819746304;1822.5261432027678;1916.6358391905537;8285.958570207147;8514.489130652157;8517.23344898959;8520.318374530038;8522.40343175977;7909.327707144886;8055.1944805519415;8058.274755272025;8067.596620168997;8074.555899425544;2294.6099163142308;2304.827137964651;2316.8841557922037;2317.860928344296;2323.175272778165;2325.662778897059;2361.622140457527;2407.38611654028;2407.831451798375;2411.8311718179734;2343.8359314847967;2359.575276450238;2362.9409264768433;2384.6661467394492;2397.125049356981;2344.4607740219676;2363.6690863279155;2374.145307689239;2377.821663375245;2409.4337830609793;2341.484873327865;2396.700412448444;2405.518896220763;2406.5908795504806;2406.831521793475;7399.778006659755;7589.127250366223;8397.53813540255;8458.281046111026;8477.74566762998;5162.6902385856965;5214.8696282592855;5269.262303277545;5271.393789714155;5277.076511610491;3413.1467133216697;3431.725461963062;3463.826808659582;3499.7900125992523;3529.1530032792202;1088.1131877519797;1155.607093588184;1159.6636975277245;1163.168334640736;1187.3054263256006;11773.764524709544;11898.345590992492;11909.642710718692;12336.876631233663;12371.814422783575;4644.86065418038;4671.11248862715;4745.857624271277;4781.2350023996;4788.904221915543;10483.47582620881;10509.684709458728;10515.421651809223;10522.263441559171;10523;5371.543418809367;5396;5397.4062853086125;5401.513863752281;5404.297441332602;4918.8770280743265;4941.579965702884;4949.579285760678;4951.752412379366;4952.331435256195;3888.941665875014;3998.3806558343917;4017.799110044486;4021.9195616087513;4042.6765858731233;1231.8398608180878;1248.1076030638137;1251.7809383357876;1258.182181581979;1261.6971926737701;994.8010397920444;1088.9782204355868;1095.3318475729798;1099.2250463423268;1100.862392200975;5797.36229014808;5861.0915308127305;6039.63762174271;6183.536234782409;6319.747210111636;1042.103790739963;1048.0881632979356;1055.488088277185;1060.3160961179997;1075.1774892207468;3493.7554371193773;3947.9605203947594;4071.3689378146437;4080.9387859182134;4135.0902801383645;9842;9936.155426788659;10103.09072183507;10111.241656875764;10129.544170512345;9860.457674827954;9938;9948;9955.20358371343;9969.052939970692;8024;8095.190480951857;8098.797530061795;8203.630836612247;8203.917960820316;5667.263255776723;5846.912296315473;5883.264591926009;5886.6173698709445;5892.322382925847;9011.729648110568;9096.044915284065;9138.771530711785;9295.11696388842;9312.301577381859;9200.309976751636;9243.76890577741;9367.437953722798;9380.76548086276;9435.764105897408;7559.659815308214;7577.924220757722;7656.923430765621;7671.578063206354;7675.04061992251;7935.047794264725;7982.241687039722;7990.920090799018;8055.959720201361;8260.917390826255;7523.811904702427;7526.661300241392;7574.697012119454;7697.846043079219;7786.338161256356;7120.750773723102;7190.173130089897;7190.712371505081;7279.1628962667855;7286.6720997556295;6660.666966651745;6673.065770791996;6698.464122870256;6698.799036028927;6702.262751097278;5011.774470148925;5075;5092.668976516515;5153.639245252796;5153.948460515347;4716.504766999416;4960.603151747924;4980.800767969386;5061.063703214917;5091.898162036812 20:18:37 INFO - PROCESS | 3408 | |4;prototype.html;362.851230995292;363.51107760062723;367.92641471705656;371.196359880858;374.3766628563442;6182.536309776768;6185.134081228621;6194.039923811805;6213.378662133796;6223.253209614847;6119.571629985903;6146.354632763562;6181.938180618193;6201.131841542187;6202.3177450480525;4457.621102206316;4632.837850675227;4770.165221086313;4771.9761401192945;4779.522047795227;4751.477337492873;4753.976230118862;4762.261849413329;4766.3088852116425;4767.332573439721;4726.338312636217;4727.66906316558;4730.834420795273;4735.171345014609;4749.311349854269;4433.246348120827;4578.06149739306;4689.062187562501;4708.176069187895;4726.031163611468;4130.401091841666;4140.4617399738145;4143.56492568282;4146.087860670647;4153.91692166155;5936.376680448534;5943.197668314765;5944.197533332988;5944.197533333031;5944.583879128462;5449.6730196188355;5493.890122197574;5495.807646732345;5496.945030549723;5497.532709719679;6501.804945851632;6504;6505.772297969548;6511.576747511396;6514.185726784152;4528.121088861071;4577.06170235101;4625.953740462586;4630;4638.327442520816;6745.392914637657;6783.42340901024;6789.694463749143;6792.864142717118;6794.728210871559;4721.197396442613;4722.929156062593;4731.124741922756;4732.006278681447;4733.668643194943;4790.0659371422935;4792.616590672737;4795.640326975491;4798.352222449995;4799.832005879847;5471.835844924659;5474.972625136928;5476.069068258405;5482.451754824486;5491.752871120809;6396.2964073951825;6507.804765857032;6532.771353002622;6543.869122617616;6543.901841472381;1675.5057258108886;1679.1939868863014;1694.1529235382309;1696.202784691193;1698.0830351609993;1140.971475713097;1145.2899202494507;1158.1487606609135;1162.7848847962985;1167.9240849344765;6135.877282454415;6241.34465881085;6392.936070639327;6430.517711171681;6435.099086127946;6793.490488213404;6797.932020679828;6798.878185099502;6800.353966373186;6808.8978665320055;6388.584741991755;6393.1688880445245;6412.262589802139;6414.166158399472;6419.165508483868;3620.637936206358;3650.324689932371;3653.1962968146963;3654.945175822365;3657.6890964267805;6862.4853136015;7102.289771022856;7123.964380178066;7126.857462850714;7128.857422851514;6828.078209441761;6836.760713375008;6865.347791959756;6887.931120688729;6894.724211031503;7083.6458177090935;7090.042844216068;7097.822554436078;7101.076860008166;7112.822179445555;6764.594124352555;6775.728970841111;6777;6778.694958726967;6783.287754785676;6509.153810004669;6674.566153200027;6687;6719.697613607302;6730.495212859153;7106.502544821813;7139.107611548557;7140.143182818095;7140.250273721393;7149.106361704787;4572.748498832596;4594.632429405707;4600.102979918884;4608.2166031774;4620.0528891577815;6777.051212830306;6841.076454678555;6846.4522838173825;6847.623380714109;6848.828779280558;6458.160439142881;6581.80254592363;6585.374389432996;6600.405963463311;6633.734650613921;6583.407493325623;6607.636579987954;6610.338966103352;6618.205815302194;6627.337266273527;6489.312778677483;6490.091387205701;6499.382558657109;6505.316941721051;6506.316836732075;6646.2356828965285;6650.301718319701;6651.501137414616;6654.866902662016;6664.100346453167;6347.96826015867;6473.320301368289;6480.384363485461;6487.351264873475;6489.9026514603265 20:18:37 INFO - PROCESS | 3408 | |5;yui.html;826.5371392020467;834.4075706248564;881.7531091294439;938.2112366697476;940.887093548774;14406.423743050278;14601.707965840676;14608;14625.92687036566;14643.56069317922;13534.39095240714;13585.932070339659;13617.455301787917;13646.317684115804;13649.181049137058;889.3285569395114;900.6847603338812;900.9144131307515;901.4501154295874;902.7833320003217;754.7471597015007;890.8841850559451;912.3431129586687;913.0686699566438;913.7304495173906;952.3143336797494;958.6596758150861;961.9422834629945;963.0754475703333;963.9132478076972;790.2729488870195;957.3155194036228;957.7653474898625;958.1807554540837;958.8753462049924;689.3451221339748;693.5180049865346;698.9475789315821;698.979030629082;699.2587856871733;13516.053876228669;13552.525661601896;13619.863801361958;13626.1143025703;13631.386587603582;14205.218712970782;14793.482228121964;14940.402383904739;14964.700705985819;15045.623859403493;12347.135700500969;12489.812652810215;12566.497340106476;12593.685157871036;12639.1784534005;4111.2188684150215;4122.154958233555;4129.050318426779;4188.979055104735;4217.451731274945;59741.103883441785;59875.40124598785;61217.6939115306;61642.075368869504;61728.69135654338;10939.23425360233;10992.835107473395;11076.889231107747;11079.556817727362;11141.665750027512;20182.09180586877;20204.19183232654;20204.39386818398;20231.494212644506;20254.291099811435;8333.624986875606;8468.788280292918;8521.36089793268;8578.142185781497;8667;4731.668783185213;4870.09903167915;4970.15507363749;5025.095482813055;5121.8719532012;3449.534312867731;3494.353544594258;3496.615372309044;3499.580050393969;3513.191965847818;634.5304474688697;646.2213033294962;653.7025653327725;654.7119267522274;655.632845606462;689.486332682155;841.7811369044092;843.1652663862732;853.5732133933034;878.2227728460358;9174.770630734152;9249.398789078688;9339.252859771203;9339.533023348806;9341.626334946526;695.4158506854267;782.5539442517824;830.4602008694276;831.2975535672347;838.0822998816286;4350.695451318441;4362.9781851091175;4391.363252328459;4603.194440972817;4767.856964291077;69322;69931.65034174797;70113.29886701067;70118;70334.29665703277;51708.48291517112;53486.7325663377;54107.18839217415;54204.45795542073;54268.45731542634;54589.454105459234;54855.45144548583;55264.17103743447;55282;55284.44715552954;10464.424456654653;10548.683539493828;10573.52419141156;10621.522031508446;10784.514696838503;39585;39598;40189.79905100456;40977;41290.38064429096;46803.29795053145;50423;51472;52223;53246.73376633092;13088;13408.128471649312;13426.932865335611;13479.797803032767;13607.523736669169;13535.255560944242;14193.716125677634;14399.496017639332;14726.631834203801;14868.776968345268;12334.32161231105;12373.195742276723;12414.193077449936;12909.870901290868;12932.676683082998;12866.35668216604;12897.871021289668;13127.277999710108;13252.138610990254;13712.93143534276;12988.90703586619;13029.804552931524;13487.730245395234;13492.797608035691;13724.862751372759;11458;11927.582534611247;11936.224145430866;12150.696232594255;12216.694582635506;10746.785064298827;11039.253121157979;11115.777684446104;11450.656480305604;11620.186586939171 20:18:37 INFO - PROCESS | 3408 | __end_tp_report 20:18:37 INFO - PROCESS | 3408 | __start_cc_report 20:18:37 INFO - PROCESS | 3408 | _x_x_mozilla_cycle_collect,812 20:18:37 INFO - PROCESS | 3408 | __end_cc_report 20:18:37 INFO - PROCESS | 3408 | __startTimestamp1467602317432__endTimestamp 20:18:37 INFO - PROCESS | 3408 | 20:18:37 INFO - PROCESS | 3408 | ------- Summary: start ------- 20:18:37 INFO - PROCESS | 3408 | Number of tests: 6 20:18:37 INFO - PROCESS | 3408 | 20:18:37 INFO - PROCESS | 3408 | [#0] dojo.html Cycles:165 Average:5540.70 Median:5776.05 stddev:618.37 (10.7%) stddev-sans-first:594.60 20:18:37 INFO - PROCESS | 3408 | Values: 3293.1 3340.2 3365.9 3394.1 3412.5 5562.2 5569.6 5571.6 5587.5 5590.9 5534.8 5549.7 5555.6 5586.2 5603.9 4994.0 5015.6 5049.4 5104.1 5149.4 5004.5 5086.4 5089.5 5093.2 5094.6 5021.6 5073.0 5135.7 5157.1 5180.4 5027.7 5032.8 5035.6 5047.2 5062.5 4936.7 4962.0 4967.8 5065.6 5145.5 5464.5 5473.8 5513.0 5531.4 5534.7 5969.7 5983.3 6000.6 6003.9 6004.7 6035.4 6056.5 6095.2 6111.2 6154.9 5483.7 5535.1 5535.4 5539.3 5553.5 5868.3 6017.2 6024.0 6025.5 6028.5 5748.2 5831.1 5836.9 5837.6 5839.9 5966.5 5967.5 5971.7 5976.4 5977.9 5819.5 5862.9 5913.3 5918.4 5923.7 5924.4 5965.6 5969.3 5973.8 6006.7 4556.1 4563.2 4563.5 4570.6 4591.4 3993.6 4011.3 4069.2 4088.9 4131.6 5572.5 5586.1 5600.9 5603.0 5628.6 5921.3 5931.6 5932.8 5933.8 5942.6 5546.9 5606.8 5617.5 5681.5 5684.0 5118.9 5142.1 5145.6 5145.7 5147.5 6241.3 6259.7 6262.1 6263.9 6264.5 5926.8 5951.0 6043.5 6049.1 6054.6 6142.9 6173.2 6183.3 6187.7 6188.0 5816.5 5819.3 5826.7 5831.8 5866.9 5870.0 5983.3 6059.7 6067.6 6083.9 5832.9 5847.8 5872.3 5876.7 5892.2 5738.4 5803.9 5891.5 5900.4 5913.6 5733.3 5795.4 5797.4 5798.1 5839.3 5864.4 5866.5 5867.6 5870.6 5874.1 5564.4 5624.9 5748.3 5755.5 5776.0 20:18:37 INFO - PROCESS | 3408 | 20:18:37 INFO - PROCESS | 3408 | [#1] ext.html Cycles:180 Average:55005.40 Median:35650.47 stddev:97046.35 (272.2%) stddev-sans-first:97232.83 20:18:37 INFO - PROCESS | 3408 | Values: 667.3 668.1 672.0 682.9 740.7 33463.2 34155.3 41048.4 41557.2 41668.0 44586.0 45121.1 45210.5 45276.0 45280.1 8045.7 8725.3 8892.6 8908.5 8908.7 10656.2 10961.2 10971.2 10975.2 10976.7 10518.7 10610.1 10614.5 10616.9 10624.7 10326.1 10336.7 10340.3 10364.3 10411.5 10332.4 10433.9 10449.2 10483.1 10484.2 44489.3 45272.8 45294.5 45308.0 45362.5 3834.6 3855.9 3897.0 4106.4 4419.7 34370.0 34383.7 34522.5 34551.5 34856.8 4598.4 4621.8 4668.8 4677.7 4685.4 317358.0 317896.0 319667.0 319976.0 320124.0 65052.0 65367.7 65671.3 65760.7 65863.0 64007.4 64337.7 71605.6 72592.6 72726.6 17483.2 17596.6 17623.7 17659.1 17660.8 13977.7 14263.8 14392.7 14636.9 14657.5 19997.4 20074.0 20275.2 20327.1 20347.4 7312.2 7624.5 7666.4 7667.5 7762.3 1120.7 1147.7 1150.2 1162.1 1233.4 34331.3 34580.8 35231.1 35487.3 35813.6 1234.0 1271.8 1279.5 1325.3 1343.9 17581.4 18237.1 18501.9 18726.5 18817.3 449483.0 455213.0 456025.0 456990.0 457497.0 52686.7 53032.0 53049.2 53106.0 53268.0 1495.0 1517.7 1529.3 1533.2 1587.4 33566.5 33958.0 34314.7 34395.5 34751.5 52178.7 52726.7 52782.2 52783.7 52836.0 282412.0 289198.0 289855.0 290991.0 410992.0 31364.5 31840.8 32109.7 32370.2 32378.5 46569.3 46951.3 47176.3 47857.0 47941.5 39834.0 42026.4 43013.6 43042.0 44252.1 40953.4 41562.0 41860.8 42008.2 43312.4 43926.0 43959.8 44432.3 47373.8 48395.8 34884.5 38746.4 39082.4 40718.8 44048.6 29330.1 29341.6 29407.3 29475.4 29540.7 20:18:37 INFO - PROCESS | 3408 | 20:18:37 INFO - PROCESS | 3408 | [#2] jquery.html Cycles:180 Average:30275.49 Median:2034.93 stddev:86147.92 (4233.5%) stddev-sans-first:86360.44 20:18:37 INFO - PROCESS | 3408 | Values: 432.9 435.5 438.4 447.9 450.2 18596.7 19084.1 19169.8 19905.8 20191.6 19078.7 19376.3 20005.9 20026.0 20029.9 5712.8 5802.7 5951.4 5956.6 5963.3 4275.6 5866.0 5883.1 6140.2 6443.3 6391.1 6407.5 6410.0 6419.1 6420.7 5741.2 6005.2 6016.1 6016.2 6353.5 3985.3 5589.2 5833.6 5840.9 5855.4 14108.3 14190.8 14343.3 14343.7 14400.6 2472.0 2547.2 2593.6 2626.3 2650.6 10995.1 11064.1 11111.5 11122.3 12908.7 2012.8 2025.3 2036.9 2075.7 2150.8 78735.0 83406.0 86703.6 86782.1 87444.0 11401.3 11532.3 11647.4 11754.3 11953.9 16762.0 16870.8 16888.7 16918.4 16935.7 8671.6 8794.1 8826.8 9019.7 9020.5 8678.4 8753.9 8847.0 8931.3 8940.7 5085.1 5179.5 5180.9 5186.8 5212.3 1884.6 2033.0 2078.8 2086.9 2101.4 1013.8 1036.4 1059.9 1066.9 1103.3 18291.1 18310.9 18492.4 19601.4 20169.4 1067.7 1095.6 1123.4 1125.6 1135.5 10876.6 11230.5 11231.6 11247.8 11274.5 510188.0 516139.0 526910.0 527390.0 530043.0 97797.0 99984.5 101009.0 101041.5 101235.0 1096.4 1121.1 1123.3 1142.8 1145.2 17045.3 17358.7 17450.0 17526.3 17683.8 40369.8 40710.6 40900.2 41496.4 42588.0 58542.0 58929.0 59113.1 59425.0 59484.7 8652.5 8658.7 8670.0 8927.5 8928.6 11040.5 13590.3 13612.7 13651.9 13788.4 11786.5 12041.5 12142.5 12253.8 12254.6 11633.2 11745.0 11854.9 11903.2 12193.1 11218.9 11972.8 12020.4 12193.7 12361.7 9062.8 9117.9 9137.2 9256.2 9455.3 9547.6 12550.0 12607.8 12613.0 12622.1 20:18:37 INFO - PROCESS | 3408 | 20:18:37 INFO - PROCESS | 3408 | [#3] mootools.html Cycles:180 Average:5628.00 Median:5036.42 stddev:3061.18 (60.8%) stddev-sans-first:3053.93 20:18:37 INFO - PROCESS | 3408 | Values: 1484.8 1599.6 1611.9 1822.5 1916.6 8286.0 8514.5 8517.2 8520.3 8522.4 7909.3 8055.2 8058.3 8067.6 8074.6 2294.6 2304.8 2316.9 2317.9 2323.2 2325.7 2361.6 2407.4 2407.8 2411.8 2343.8 2359.6 2362.9 2384.7 2397.1 2344.5 2363.7 2374.1 2377.8 2409.4 2341.5 2396.7 2405.5 2406.6 2406.8 7399.8 7589.1 8397.5 8458.3 8477.7 5162.7 5214.9 5269.3 5271.4 5277.1 3413.1 3431.7 3463.8 3499.8 3529.2 1088.1 1155.6 1159.7 1163.2 1187.3 11773.8 11898.3 11909.6 12336.9 12371.8 4644.9 4671.1 4745.9 4781.2 4788.9 10483.5 10509.7 10515.4 10522.3 10523.0 5371.5 5396.0 5397.4 5401.5 5404.3 4918.9 4941.6 4949.6 4951.8 4952.3 3888.9 3998.4 4017.8 4021.9 4042.7 1231.8 1248.1 1251.8 1258.2 1261.7 994.8 1089.0 1095.3 1099.2 1100.9 5797.4 5861.1 6039.6 6183.5 6319.7 1042.1 1048.1 1055.5 1060.3 1075.2 3493.8 3948.0 4071.4 4080.9 4135.1 9842.0 9936.2 10103.1 10111.2 10129.5 9860.5 9938.0 9948.0 9955.2 9969.1 8024.0 8095.2 8098.8 8203.6 8203.9 5667.3 5846.9 5883.3 5886.6 5892.3 9011.7 9096.0 9138.8 9295.1 9312.3 9200.3 9243.8 9367.4 9380.8 9435.8 7559.7 7577.9 7656.9 7671.6 7675.0 7935.0 7982.2 7990.9 8056.0 8260.9 7523.8 7526.7 7574.7 7697.8 7786.3 7120.8 7190.2 7190.7 7279.2 7286.7 6660.7 6673.1 6698.5 6698.8 6702.3 5011.8 5075.0 5092.7 5153.6 5153.9 4716.5 4960.6 4980.8 5061.1 5091.9 20:18:37 INFO - PROCESS | 3408 | 20:18:37 INFO - PROCESS | 3408 | [#4] prototype.html Cycles:180 Average:5509.92 Median:6232.30 stddev:1656.91 (26.6%) stddev-sans-first:1615.89 20:18:37 INFO - PROCESS | 3408 | Values: 362.9 363.5 367.9 371.2 374.4 6182.5 6185.1 6194.0 6213.4 6223.3 6119.6 6146.4 6181.9 6201.1 6202.3 4457.6 4632.8 4770.2 4772.0 4779.5 4751.5 4754.0 4762.3 4766.3 4767.3 4726.3 4727.7 4730.8 4735.2 4749.3 4433.2 4578.1 4689.1 4708.2 4726.0 4130.4 4140.5 4143.6 4146.1 4153.9 5936.4 5943.2 5944.2 5944.2 5944.6 5449.7 5493.9 5495.8 5496.9 5497.5 6501.8 6504.0 6505.8 6511.6 6514.2 4528.1 4577.1 4626.0 4630.0 4638.3 6745.4 6783.4 6789.7 6792.9 6794.7 4721.2 4722.9 4731.1 4732.0 4733.7 4790.1 4792.6 4795.6 4798.4 4799.8 5471.8 5475.0 5476.1 5482.5 5491.8 6396.3 6507.8 6532.8 6543.9 6543.9 1675.5 1679.2 1694.2 1696.2 1698.1 1141.0 1145.3 1158.1 1162.8 1167.9 6135.9 6241.3 6392.9 6430.5 6435.1 6793.5 6797.9 6798.9 6800.4 6808.9 6388.6 6393.2 6412.3 6414.2 6419.2 3620.6 3650.3 3653.2 3654.9 3657.7 6862.5 7102.3 7124.0 7126.9 7128.9 6828.1 6836.8 6865.3 6887.9 6894.7 7083.6 7090.0 7097.8 7101.1 7112.8 6764.6 6775.7 6777.0 6778.7 6783.3 6509.2 6674.6 6687.0 6719.7 6730.5 7106.5 7139.1 7140.1 7140.3 7149.1 4572.7 4594.6 4600.1 4608.2 4620.1 6777.1 6841.1 6846.5 6847.6 6848.8 6458.2 6581.8 6585.4 6600.4 6633.7 6583.4 6607.6 6610.3 6618.2 6627.3 6489.3 6490.1 6499.4 6505.3 6506.3 6646.2 6650.3 6651.5 6654.9 6664.1 6348.0 6473.3 6480.4 6487.4 6489.9 20:18:37 INFO - PROCESS | 3408 | 20:18:37 INFO - PROCESS | 3408 | [#5] yui.html Cycles:180 Average:15941.88 Median:4356.84 stddev:18737.17 (430.1%) stddev-sans-first:18755.35 20:18:37 INFO - PROCESS | 3408 | Values: 826.5 834.4 881.8 938.2 940.9 14406.4 14601.7 14608.0 14625.9 14643.6 13534.4 13585.9 13617.5 13646.3 13649.2 889.3 900.7 900.9 901.5 902.8 754.7 890.9 912.3 913.1 913.7 952.3 958.7 961.9 963.1 963.9 790.3 957.3 957.8 958.2 958.9 689.3 693.5 698.9 699.0 699.3 13516.1 13552.5 13619.9 13626.1 13631.4 14205.2 14793.5 14940.4 14964.7 15045.6 12347.1 12489.8 12566.5 12593.7 12639.2 4111.2 4122.2 4129.1 4189.0 4217.5 59741.1 59875.4 61217.7 61642.1 61728.7 10939.2 10992.8 11076.9 11079.6 11141.7 20182.1 20204.2 20204.4 20231.5 20254.3 8333.6 8468.8 8521.4 8578.1 8667.0 4731.7 4870.1 4970.2 5025.1 5121.9 3449.5 3494.4 3496.6 3499.6 3513.2 634.5 646.2 653.7 654.7 655.6 689.5 841.8 843.2 853.6 878.2 9174.8 9249.4 9339.3 9339.5 9341.6 695.4 782.6 830.5 831.3 838.1 4350.7 4363.0 4391.4 4603.2 4767.9 69322.0 69931.7 70113.3 70118.0 70334.3 51708.5 53486.7 54107.2 54204.5 54268.5 54589.5 54855.5 55264.2 55282.0 55284.4 10464.4 10548.7 10573.5 10621.5 10784.5 39585.0 39598.0 40189.8 40977.0 41290.4 46803.3 50423.0 51472.0 52223.0 53246.7 13088.0 13408.1 13426.9 13479.8 13607.5 13535.3 14193.7 14399.5 14726.6 14868.8 12334.3 12373.2 12414.2 12909.9 12932.7 12866.4 12897.9 13127.3 13252.1 13712.9 12988.9 13029.8 13487.7 13492.8 13724.9 11458.0 11927.6 11936.2 12150.7 12216.7 10746.8 11039.3 11115.8 11450.7 11620.2 20:18:37 INFO - PROCESS | 3408 | -------- Summary: end -------- 20:18:37 INFO - PROCESS | 3408 | 20:18:38 INFO - TEST-INFO | 3408: exit 0 20:18:38 INFO - TEST-OK | dromaeo_css | took 1112135ms 20:18:38 INFO - TEST-START | kraken 20:18:38 INFO - operating with platform_type : linux_ 20:18:38 INFO - Initialising browser for kraken test... 20:18:38 INFO - TEST-INFO | started process 3602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYPnEz2/profile http://localhost:52773/getInfo.html) 20:18:42 INFO - PROCESS | 3602 | __metrics Screen width/height:1600/1200 20:18:42 INFO - PROCESS | 3602 | colorDepth:24 20:18:42 INFO - PROCESS | 3602 | Browser inner width/height: 1024/697 20:18:42 INFO - PROCESS | 3602 | __metrics 20:18:43 ERROR - PROCESS | 3602 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:18:44 INFO - TEST-INFO | 3602: exit 0 20:18:44 INFO - Browser initialized. 20:18:44 INFO - Running cycle 1/1 for kraken test... 20:18:44 INFO - TEST-INFO | started process 3697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYPnEz2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:56 INFO - PROCESS | 3697 | RSS: Main: 139276288 20:18:56 INFO - PROCESS | 3697 | 20:18:58 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52773/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:59 INFO - PROCESS | 3697 | RSS: Main: 197869568 20:18:59 INFO - PROCESS | 3697 | 20:19:02 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52773/tests/kraken/driver.html?testName=audio-dft) 20:19:02 INFO - PROCESS | 3697 | RSS: Main: 184987648 20:19:02 INFO - PROCESS | 3697 | 20:19:05 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52773/tests/kraken/driver.html?testName=audio-fft) 20:19:06 INFO - PROCESS | 3697 | RSS: Main: 273506304 20:19:06 INFO - PROCESS | 3697 | 20:19:08 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52773/tests/kraken/driver.html?testName=audio-oscillator) 20:19:08 INFO - PROCESS | 3697 | RSS: Main: 181006336 20:19:08 INFO - PROCESS | 3697 | 20:19:10 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:19:11 INFO - PROCESS | 3697 | RSS: Main: 179093504 20:19:11 INFO - PROCESS | 3697 | 20:19:14 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52773/tests/kraken/driver.html?testName=imaging-darkroom) 20:19:15 INFO - PROCESS | 3697 | RSS: Main: 213540864 20:19:15 INFO - PROCESS | 3697 | 20:19:18 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52773/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:19 INFO - PROCESS | 3697 | RSS: Main: 213245952 20:19:19 INFO - PROCESS | 3697 | 20:19:21 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52773/tests/kraken/driver.html?testName=json-parse-financial) 20:19:22 INFO - PROCESS | 3697 | RSS: Main: 213913600 20:19:22 INFO - PROCESS | 3697 | 20:19:23 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:24 INFO - PROCESS | 3697 | RSS: Main: 193929216 20:19:24 INFO - PROCESS | 3697 | 20:19:26 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:26 INFO - PROCESS | 3697 | RSS: Main: 198238208 20:19:26 INFO - PROCESS | 3697 | 20:19:29 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:29 INFO - PROCESS | 3697 | RSS: Main: 210747392 20:19:29 INFO - PROCESS | 3697 | 20:19:32 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:32 INFO - PROCESS | 3697 | RSS: Main: 217292800 20:19:32 INFO - PROCESS | 3697 | 20:19:35 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:36 INFO - PROCESS | 3697 | RSS: Main: 214974464 20:19:36 INFO - PROCESS | 3697 | 20:19:37 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:52773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52773/tests/kraken/driver.html?testName=ai-astar) 20:19:38 INFO - PROCESS | 3697 | RSS: Main: 276049920 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | __start_tp_report 20:19:38 INFO - PROCESS | 3697 | _x_x_mozilla_page_load 20:19:38 INFO - PROCESS | 3697 | _x_x_mozilla_page_load_details 20:19:38 INFO - PROCESS | 3697 | |i|pagename|runs| 20:19:38 INFO - PROCESS | 3697 | |0;ai-astar;112;111;110;111;110;112;104;110;108;109 20:19:38 INFO - PROCESS | 3697 | |1;audio-beat-detection;153;131;164;182;135;155;152;131;179;126 20:19:38 INFO - PROCESS | 3697 | |2;audio-dft;160;159;160;159;162;163;164;161;159;160 20:19:38 INFO - PROCESS | 3697 | |3;audio-fft;75;75;75;177;74;76;76;73;151;76 20:19:38 INFO - PROCESS | 3697 | |4;audio-oscillator;93;93;151;92;93;92;145;92;91;152 20:19:38 INFO - PROCESS | 3697 | |5;imaging-gaussian-blur;117;117;116;118;116;116;116;117;118;116 20:19:38 INFO - PROCESS | 3697 | |6;imaging-darkroom;145;146;146;145;147;146;146;145;147;145 20:19:38 INFO - PROCESS | 3697 | |7;imaging-desaturate;94;96;96;95;95;94;95;94;95;94 20:19:38 INFO - PROCESS | 3697 | |8;json-parse-financial;54;53;53;53;55;55;56;75;52;52 20:19:38 INFO - PROCESS | 3697 | |9;json-stringify-tinderbox;59;57;57;56;58;57;57;57;58;58 20:19:38 INFO - PROCESS | 3697 | |10;stanford-crypto-aes;72;71;72;75;73;71;73;72;72;72 20:19:38 INFO - PROCESS | 3697 | |11;stanford-crypto-ccm;121;113;112;111;115;109;109;108;127;112 20:19:38 INFO - PROCESS | 3697 | |12;stanford-crypto-pbkdf2;161;159;160;162;162;164;154;155;152;155 20:19:38 INFO - PROCESS | 3697 | |13;stanford-crypto-sha256-iterative;66;67;67;69;67;66;66;65;65;69 20:19:38 INFO - PROCESS | 3697 | __end_tp_report 20:19:38 INFO - PROCESS | 3697 | __start_cc_report 20:19:38 INFO - PROCESS | 3697 | _x_x_mozilla_cycle_collect,1575 20:19:38 INFO - PROCESS | 3697 | __end_cc_report 20:19:38 INFO - PROCESS | 3697 | __startTimestamp1467602378059__endTimestamp 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | ------- Summary: start ------- 20:19:38 INFO - PROCESS | 3697 | Number of tests: 14 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.36 (2.1%) stddev-sans-first:2.35 20:19:38 INFO - PROCESS | 3697 | Values: 112.0 111.0 110.0 111.0 110.0 112.0 104.0 110.0 108.0 109.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:154.00 stddev:20.04 (13.0%) stddev-sans-first:21.24 20:19:38 INFO - PROCESS | 3697 | Values: 153.0 131.0 164.0 182.0 135.0 155.0 152.0 131.0 179.0 126.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.77 (1.1%) stddev-sans-first:1.86 20:19:38 INFO - PROCESS | 3697 | Values: 160.0 159.0 160.0 159.0 162.0 163.0 164.0 161.0 159.0 160.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:38.03 (50.7%) stddev-sans-first:39.79 20:19:38 INFO - PROCESS | 3697 | Values: 75.0 75.0 75.0 177.0 74.0 76.0 76.0 73.0 151.0 76.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.00 stddev:27.62 (30.0%) stddev-sans-first:28.65 20:19:38 INFO - PROCESS | 3697 | Values: 93.0 93.0 151.0 92.0 93.0 92.0 145.0 92.0 91.0 152.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 20:19:38 INFO - PROCESS | 3697 | Values: 117.0 117.0 116.0 118.0 116.0 116.0 116.0 117.0 118.0 116.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 20:19:38 INFO - PROCESS | 3697 | Values: 145.0 146.0 146.0 145.0 147.0 146.0 146.0 145.0 147.0 145.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 20:19:38 INFO - PROCESS | 3697 | Values: 94.0 96.0 96.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:54.50 stddev:6.88 (12.6%) stddev-sans-first:7.26 20:19:38 INFO - PROCESS | 3697 | Values: 54.0 53.0 53.0 53.0 55.0 55.0 56.0 75.0 52.0 52.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:57.50 stddev:0.84 (1.5%) stddev-sans-first:0.67 20:19:38 INFO - PROCESS | 3697 | Values: 59.0 57.0 57.0 56.0 58.0 57.0 57.0 57.0 58.0 58.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.00 stddev:1.16 (1.6%) stddev-sans-first:1.22 20:19:38 INFO - PROCESS | 3697 | Values: 72.0 71.0 72.0 75.0 73.0 71.0 73.0 72.0 72.0 72.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:112.50 stddev:5.98 (5.3%) stddev-sans-first:5.73 20:19:38 INFO - PROCESS | 3697 | Values: 121.0 113.0 112.0 111.0 115.0 109.0 109.0 108.0 127.0 112.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:160.50 stddev:4.09 (2.5%) stddev-sans-first:4.23 20:19:38 INFO - PROCESS | 3697 | Values: 161.0 159.0 160.0 162.0 162.0 164.0 154.0 155.0 152.0 155.0 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - PROCESS | 3697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.42 (2.1%) stddev-sans-first:1.48 20:19:38 INFO - PROCESS | 3697 | Values: 66.0 67.0 67.0 69.0 67.0 66.0 66.0 65.0 65.0 69.0 20:19:38 INFO - PROCESS | 3697 | -------- Summary: end -------- 20:19:38 INFO - PROCESS | 3697 | 20:19:38 INFO - TEST-INFO | 3697: exit 0 20:19:39 INFO - TEST-OK | kraken | took 60954ms 20:19:39 INFO - SUITE-END | took 1173s 20:19:39 INFO - Completed test suite (00:19:33) 20:19:39 INFO - javascript benchmark 20:19:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.1437826165193, 3340.2150494633765, 3365.89902302931, 3394.0666316762904, 3412.4881267809824, 5562.221289019535, 5569.610127291091, 5571.637843540167, 5587.497125258726, 5590.86022849429, 5534.833954981347, 5549.722513874311, 5555.555555555556, 5586.190002449643, 5603.887922241553, 4993.950060499403, 5015.598752099832, 5049.444561098277, 5104.0812653722505, 5149.407818100929, 5004.524570165829, 5086.41506226785, 5089.465606111342, 5093.185090385539, 5094.6433749637545, 5021.573166280852, 5072.9746351268195, 5135.691858488484, 5157.123289040872, 5180.378354597454, 5027.698338099707, 5032.798688052473, 5035.62232832539, 5047.167217409123, 5062.493750624926, 4936.728479933602, 4962.0, 4967.826126085606, 5065.645404821664, 5145.536901678867, 5464.508194262536, 5473.808416705396, 5512.972435137839, 5531.419200983879, 5534.667919924817, 5969.70151492428, 5983.252093488314, 6000.609960352563, 6003.879922401527, 6004.669743164124, 6035.39646035393, 6056.4851987581105, 6095.238095238095, 6111.174991376151, 6154.938450615481, 5483.698396588186, 5535.086710692731, 5535.363433205192, 5539.335279766454, 5553.4724201200825, 5868.295804503401, 6017.187679663277, 6024.036154215304, 6025.517958563304, 6028.5478589106, 5748.166515855178, 5831.067029275296, 5836.9124463133085, 5837.562182836305, 5839.941600583939, 5966.463018328372, 5967.462928336384, 5971.731272092767, 5976.402359763989, 5977.850553736104, 5819.476247137778, 5862.882742345129, 5913.349531551526, 5918.378570250148, 5923.674197919069, 5924.437178468039, 5965.642061476238, 5969.253843269591, 5973.790917317873, 6006.729697163551, 4556.066006468666, 4563.155816174019, 4563.520830312836, 4570.565796249351, 4591.4260717410325, 3993.6405723485027, 4011.3180759270995, 4069.2268468990796, 4088.8568900088353, 4131.586841315904, 5572.4706152916215, 5586.050371436865, 5600.943990560124, 5602.971985140048, 5628.60599758013, 5921.259842519685, 5931.6441013539325, 5932.762689492372, 5933.762649494059, 5942.554308426799, 5546.944530554723, 5606.775728970877, 5617.466340697627, 5681.488666020078, 5684.0, 5118.897622047538, 5142.125838607446, 5145.614078944094, 5145.665531740425, 5147.459516750762, 6241.251049874044, 6259.7496100156395, 6262.060690896311, 6263.874722505524, 6264.5301602379095, 5926.762929482945, 5950.970245148833, 6043.516518678583, 6049.062395328731, 6054.636721796706, 6142.871395789577, 6173.197484327009, 6183.288921773874, 6187.690615469119, 6188.040853667689, 5816.47651711348, 5819.330776960704, 5826.650400975955, 5831.79588714393, 5866.882662346815, 5869.970650146722, 5983.252093488314, 6059.697015149313, 6067.605605635619, 6083.939160608337, 5832.854178645568, 5847.766089356548, 5872.29532456108, 5876.676782776988, 5892.175095486721, 5738.426157384228, 5803.883922321615, 5891.469767720926, 5900.409959004065, 5913.556483263858, 5733.283339582552, 5795.39148389413, 5797.362290148165, 5798.1302804579655, 5839.270091238595, 5864.44287792659, 5866.50134738552, 5867.559933004956, 5870.647761134345, 5874.148248504029, 5564.443555644403, 5624.915626265528, 5748.338941021836, 5755.53955683536, 5776.046952252831], "value": 5500.410588265024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.3326673326674, 668.1080757189152, 672.0456951129397, 682.9346219896961, 740.7185269597555, 33463.16342091449, 34155.316893662144, 41048.384274235876, 41557.16885662285, 41668.0, 44586.0, 45121.09757804842, 45210.54789452104, 45276.0, 45280.0943981121, 8045.678172873078, 8725.34559908008, 8892.59983300753, 8908.465492070463, 8908.73273801787, 10656.200784941122, 10961.232713710044, 10971.177161712863, 10975.231733778639, 10976.725581860477, 10518.684439466828, 10610.098141657969, 10614.460903169036, 10616.946915265413, 10624.681259562225, 10326.070653641209, 10336.689899303034, 10340.327878687936, 10364.32631878933, 10411.479426028705, 10332.431716255604, 10433.895661043369, 10449.164066874631, 10483.10893574047, 10484.161267098614, 44489.33266001013, 45272.77363613194, 45294.547054529365, 45308.0, 45362.54637453616, 3834.559025712051, 3855.8843234703004, 3897.0452239201577, 4106.425100485934, 4419.712718673276, 34370.0, 34383.656163438296, 34522.48216276758, 34551.4817277741, 34856.82571587151, 4598.448186217642, 4621.838235661769, 4668.789904454274, 4677.719336839767, 4685.367475390813, 317358.0, 317896.0, 319667.0, 319976.0, 320124.0, 65052.0, 65367.67316163389, 65671.34328656652, 65760.67119664371, 65863.0, 64007.35992640107, 64337.67831160814, 71605.64197179084, 72592.63703681447, 72726.63636681889, 17483.213255403538, 17596.648067038586, 17623.735643965094, 17659.11704414774, 17660.823391766175, 13977.650558736113, 14263.78604320936, 14392.712145757236, 14636.926815365856, 14657.486987955584, 19997.400077997685, 20074.0, 20275.188992440137, 20327.085281162384, 20347.389578312675, 7312.1956584775635, 7624.504407213513, 7666.3866890648615, 7667.501612395288, 7762.301392874669, 1120.6638008597552, 1147.718808891827, 1150.2121047082776, 1162.1092780023546, 1233.3894722112611, 34331.31337373239, 34580.82709586436, 35231.11922201965, 35487.29025419477, 35813.64186358103, 1233.9568115115928, 1271.8124825300467, 1279.500994612102, 1325.2644782145808, 1343.9260840653858, 17581.384651537133, 18237.08814559267, 18501.90749046246, 18726.53183670419, 18817.341393051178, 449483.0, 455213.0, 456025.0, 456990.0, 457497.0, 52686.736566316926, 53032.0, 53049.2042619361, 53106.0, 53268.0, 1494.9626259343386, 1517.681286929757, 1529.342382775395, 1533.2410456823943, 1587.4443944619522, 33566.49650255199, 33958.0, 34314.65685343214, 34395.484067739504, 34751.47872781961, 52178.73910630422, 52726.681832954484, 52782.20826687526, 52783.736081319345, 52836.0, 282412.0, 289198.0, 289855.0, 290991.0, 410992.0, 31364.529532057495, 31840.840795795873, 32109.678903210668, 32370.190745230615, 32378.514322285657, 46569.3014604788, 46951.29573056475, 47176.29235561538, 47857.0, 47941.5205847937, 39834.0, 42026.369604456566, 43013.56986430095, 43042.0, 44252.11495770131, 40953.385699215134, 41562.0, 41860.79069604632, 42008.1598368037, 43312.350314744675, 43926.0, 43959.78020109879, 44432.33351499665, 47373.763131184125, 48395.75802121108, 34884.476732849536, 38746.41880371853, 39082.413763792996, 40718.79640601896, 44048.55951440445, 29330.09354391958, 29341.559876602296, 29407.264818378855, 29475.410491790473, 29540.704592954655], "value": 21251.56370917039, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.9437173167488, 435.52092698032186, 438.4198988950028, 447.8745951133683, 450.1739308369142, 18596.721049184256, 19084.141213645384, 19169.808301916975, 19905.800941990576, 20191.59616807663, 19078.713819292687, 19376.321828735996, 20005.899970500126, 20026.0, 20029.899850500762, 5712.771489140429, 5802.738876750556, 5951.404859514036, 5956.583039187259, 5963.284405871302, 4275.636570891478, 5865.970670146665, 5883.088121341178, 6140.201773769404, 6443.29123796382, 6391.073294372313, 6407.487401007908, 6410.0, 6419.069234960928, 6420.678966051702, 5741.167530708045, 6005.159277701126, 6016.127661489059, 6016.187814645011, 6353.459955903731, 3985.322495175798, 5589.189567512729, 5833.620814647034, 5840.853978650525, 5855.4144585541535, 14108.294585270798, 14190.787138192833, 14343.282835858165, 14343.713125737428, 14400.63998400038, 2471.95056098877, 2547.172169045049, 2593.5590949538623, 2626.2515183172704, 2650.615660729203, 10995.065419439357, 11064.114870810316, 11111.499982500807, 11122.332660040423, 12908.741825163537, 2012.788657191003, 2025.3012710614814, 2036.908339124743, 2075.6575165097893, 2150.849440539163, 78735.0, 83405.99999999939, 86703.56648216782, 86782.13217867803, 87444.0, 11401.258918170459, 11532.308061516336, 11647.41762911868, 11754.29474231549, 11953.940230298967, 16762.0, 16870.831291687173, 16888.662226755398, 16918.407855724992, 16935.745963810554, 8671.609777560025, 8794.120587941155, 8826.823463530693, 9019.729408117766, 9020.503872286956, 8678.39251252419, 8753.868691969625, 8847.02682704902, 8931.285497160212, 8940.68707595231, 5085.1355269604255, 5179.48205179479, 5180.870478238075, 5186.766595503212, 5212.3223980883, 1884.575970406675, 2032.9593408131755, 2078.8233000195155, 2086.8747875127237, 2101.443117573844, 1013.8225810483136, 1036.3781730961364, 1059.9470026498643, 1066.9306495077794, 1103.3269705479652, 18291.085445727662, 18310.908445457953, 18492.35276765307, 19601.411957641292, 20169.39491815248, 1067.69570672358, 1095.6439157273917, 1123.43828085957, 1125.634168895096, 1135.5117299561102, 10876.61931832398, 11230.494627741771, 11231.55073797039, 11247.775044499063, 11274.492647830868, 510188.0, 516139.0, 526910.0, 527390.0, 530043.0, 97797.0, 99984.50007749915, 101009.0, 101041.49479252557, 101235.0, 1096.3750662122673, 1121.0695123047851, 1123.2811000959393, 1142.8000099982469, 1145.1583086431467, 17045.318187272867, 17358.652826943642, 17450.0, 17526.298948041935, 17683.79052369077, 40369.798151009054, 40710.59289407068, 40900.18199635931, 41496.377554336104, 42588.0, 58542.0, 58929.0, 59113.11330329962, 59425.0, 59484.70257648684, 8652.524111173945, 8658.740237792876, 8670.0, 8927.464352138892, 8928.598213080297, 11040.503177356877, 13590.252536110609, 13612.727745445234, 13651.863481365059, 13788.448462061806, 11786.46960886745, 12041.518339266331, 12142.453589588313, 12253.754924901274, 12254.571090011807, 11633.185677002528, 11745.001674857733, 11854.881451185378, 11903.226290291102, 12193.146479746332, 11218.943905280421, 11972.820407693718, 12020.398980050788, 12193.69515762113, 12361.724143102265, 9062.818743625223, 9117.863232051392, 9137.223336016514, 9256.166944974715, 9455.338126331091, 9547.618095276111, 12550.0, 12607.810882836948, 12613.0, 12622.11645184865], "value": 9552.07042176481, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.8440913704053, 1599.6240883392402, 1611.9435819746304, 1822.5261432027678, 1916.6358391905537, 8285.958570207147, 8514.489130652157, 8517.23344898959, 8520.318374530038, 8522.40343175977, 7909.327707144886, 8055.1944805519415, 8058.274755272025, 8067.596620168997, 8074.555899425544, 2294.6099163142308, 2304.827137964651, 2316.8841557922037, 2317.860928344296, 2323.175272778165, 2325.662778897059, 2361.622140457527, 2407.38611654028, 2407.831451798375, 2411.8311718179734, 2343.8359314847967, 2359.575276450238, 2362.9409264768433, 2384.6661467394492, 2397.125049356981, 2344.4607740219676, 2363.6690863279155, 2374.145307689239, 2377.821663375245, 2409.4337830609793, 2341.484873327865, 2396.700412448444, 2405.518896220763, 2406.5908795504806, 2406.831521793475, 7399.778006659755, 7589.127250366223, 8397.53813540255, 8458.281046111026, 8477.74566762998, 5162.6902385856965, 5214.8696282592855, 5269.262303277545, 5271.393789714155, 5277.076511610491, 3413.1467133216697, 3431.725461963062, 3463.826808659582, 3499.7900125992523, 3529.1530032792202, 1088.1131877519797, 1155.607093588184, 1159.6636975277245, 1163.168334640736, 1187.3054263256006, 11773.764524709544, 11898.345590992492, 11909.642710718692, 12336.876631233663, 12371.814422783575, 4644.86065418038, 4671.11248862715, 4745.857624271277, 4781.2350023996, 4788.904221915543, 10483.47582620881, 10509.684709458728, 10515.421651809223, 10522.263441559171, 10523.0, 5371.543418809367, 5396.0, 5397.4062853086125, 5401.513863752281, 5404.297441332602, 4918.8770280743265, 4941.579965702884, 4949.579285760678, 4951.752412379366, 4952.331435256195, 3888.941665875014, 3998.3806558343917, 4017.799110044486, 4021.9195616087513, 4042.6765858731233, 1231.8398608180878, 1248.1076030638137, 1251.7809383357876, 1258.182181581979, 1261.6971926737701, 994.8010397920444, 1088.9782204355868, 1095.3318475729798, 1099.2250463423268, 1100.862392200975, 5797.36229014808, 5861.0915308127305, 6039.63762174271, 6183.536234782409, 6319.747210111636, 1042.103790739963, 1048.0881632979356, 1055.488088277185, 1060.3160961179997, 1075.1774892207468, 3493.7554371193773, 3947.9605203947594, 4071.3689378146437, 4080.9387859182134, 4135.0902801383645, 9842.0, 9936.155426788659, 10103.09072183507, 10111.241656875764, 10129.544170512345, 9860.457674827954, 9938.0, 9948.0, 9955.20358371343, 9969.052939970692, 8024.0, 8095.190480951857, 8098.797530061795, 8203.630836612247, 8203.917960820316, 5667.263255776723, 5846.912296315473, 5883.264591926009, 5886.6173698709445, 5892.322382925847, 9011.729648110568, 9096.044915284065, 9138.771530711785, 9295.11696388842, 9312.301577381859, 9200.309976751636, 9243.76890577741, 9367.437953722798, 9380.76548086276, 9435.764105897408, 7559.659815308214, 7577.924220757722, 7656.923430765621, 7671.578063206354, 7675.04061992251, 7935.047794264725, 7982.241687039722, 7990.920090799018, 8055.959720201361, 8260.917390826255, 7523.811904702427, 7526.661300241392, 7574.697012119454, 7697.846043079219, 7786.338161256356, 7120.750773723102, 7190.173130089897, 7190.712371505081, 7279.1628962667855, 7286.6720997556295, 6660.666966651745, 6673.065770791996, 6698.464122870256, 6698.799036028927, 6702.262751097278, 5011.774470148925, 5075.0, 5092.668976516515, 5153.639245252796, 5153.948460515347, 4716.504766999416, 4960.603151747924, 4980.800767969386, 5061.063703214917, 5091.898162036812], "value": 4598.664933008457, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.851230995292, 363.51107760062723, 367.92641471705656, 371.196359880858, 374.3766628563442, 6182.536309776768, 6185.134081228621, 6194.039923811805, 6213.378662133796, 6223.253209614847, 6119.571629985903, 6146.354632763562, 6181.938180618193, 6201.131841542187, 6202.3177450480525, 4457.621102206316, 4632.837850675227, 4770.165221086313, 4771.9761401192945, 4779.522047795227, 4751.477337492873, 4753.976230118862, 4762.261849413329, 4766.3088852116425, 4767.332573439721, 4726.338312636217, 4727.66906316558, 4730.834420795273, 4735.171345014609, 4749.311349854269, 4433.246348120827, 4578.06149739306, 4689.062187562501, 4708.176069187895, 4726.031163611468, 4130.401091841666, 4140.4617399738145, 4143.56492568282, 4146.087860670647, 4153.91692166155, 5936.376680448534, 5943.197668314765, 5944.197533332988, 5944.197533333031, 5944.583879128462, 5449.6730196188355, 5493.890122197574, 5495.807646732345, 5496.945030549723, 5497.532709719679, 6501.804945851632, 6504.0, 6505.772297969548, 6511.576747511396, 6514.185726784152, 4528.121088861071, 4577.06170235101, 4625.953740462586, 4630.0, 4638.327442520816, 6745.392914637657, 6783.42340901024, 6789.694463749143, 6792.864142717118, 6794.728210871559, 4721.197396442613, 4722.929156062593, 4731.124741922756, 4732.006278681447, 4733.668643194943, 4790.0659371422935, 4792.616590672737, 4795.640326975491, 4798.352222449995, 4799.832005879847, 5471.835844924659, 5474.972625136928, 5476.069068258405, 5482.451754824486, 5491.752871120809, 6396.2964073951825, 6507.804765857032, 6532.771353002622, 6543.869122617616, 6543.901841472381, 1675.5057258108886, 1679.1939868863014, 1694.1529235382309, 1696.202784691193, 1698.0830351609993, 1140.971475713097, 1145.2899202494507, 1158.1487606609135, 1162.7848847962985, 1167.9240849344765, 6135.877282454415, 6241.34465881085, 6392.936070639327, 6430.517711171681, 6435.099086127946, 6793.490488213404, 6797.932020679828, 6798.878185099502, 6800.353966373186, 6808.8978665320055, 6388.584741991755, 6393.1688880445245, 6412.262589802139, 6414.166158399472, 6419.165508483868, 3620.637936206358, 3650.324689932371, 3653.1962968146963, 3654.945175822365, 3657.6890964267805, 6862.4853136015, 7102.289771022856, 7123.964380178066, 7126.857462850714, 7128.857422851514, 6828.078209441761, 6836.760713375008, 6865.347791959756, 6887.931120688729, 6894.724211031503, 7083.6458177090935, 7090.042844216068, 7097.822554436078, 7101.076860008166, 7112.822179445555, 6764.594124352555, 6775.728970841111, 6777.0, 6778.694958726967, 6783.287754785676, 6509.153810004669, 6674.566153200027, 6687.0, 6719.697613607302, 6730.495212859153, 7106.502544821813, 7139.107611548557, 7140.143182818095, 7140.250273721393, 7149.106361704787, 4572.748498832596, 4594.632429405707, 4600.102979918884, 4608.2166031774, 4620.0528891577815, 6777.051212830306, 6841.076454678555, 6846.4522838173825, 6847.623380714109, 6848.828779280558, 6458.160439142881, 6581.80254592363, 6585.374389432996, 6600.405963463311, 6633.734650613921, 6583.407493325623, 6607.636579987954, 6610.338966103352, 6618.205815302194, 6627.337266273527, 6489.312778677483, 6490.091387205701, 6499.382558657109, 6505.316941721051, 6506.316836732075, 6646.2356828965285, 6650.301718319701, 6651.501137414616, 6654.866902662016, 6664.100346453167, 6347.96826015867, 6473.320301368289, 6480.384363485461, 6487.351264873475, 6489.9026514603265], "value": 4980.5804752008535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.5371392020467, 834.4075706248564, 881.7531091294439, 938.2112366697476, 940.887093548774, 14406.423743050278, 14601.707965840676, 14608.0, 14625.92687036566, 14643.56069317922, 13534.39095240714, 13585.932070339659, 13617.455301787917, 13646.317684115804, 13649.181049137058, 889.3285569395114, 900.6847603338812, 900.9144131307515, 901.4501154295874, 902.7833320003217, 754.7471597015007, 890.8841850559451, 912.3431129586687, 913.0686699566438, 913.7304495173906, 952.3143336797494, 958.6596758150861, 961.9422834629945, 963.0754475703333, 963.9132478076972, 790.2729488870195, 957.3155194036228, 957.7653474898625, 958.1807554540837, 958.8753462049924, 689.3451221339748, 693.5180049865346, 698.9475789315821, 698.979030629082, 699.2587856871733, 13516.053876228669, 13552.525661601896, 13619.863801361958, 13626.1143025703, 13631.386587603582, 14205.218712970782, 14793.482228121964, 14940.402383904739, 14964.700705985819, 15045.623859403493, 12347.135700500969, 12489.812652810215, 12566.497340106476, 12593.685157871036, 12639.1784534005, 4111.2188684150215, 4122.154958233555, 4129.050318426779, 4188.979055104735, 4217.451731274945, 59741.103883441785, 59875.40124598785, 61217.6939115306, 61642.075368869504, 61728.69135654338, 10939.23425360233, 10992.835107473395, 11076.889231107747, 11079.556817727362, 11141.665750027512, 20182.09180586877, 20204.19183232654, 20204.39386818398, 20231.494212644506, 20254.291099811435, 8333.624986875606, 8468.788280292918, 8521.36089793268, 8578.142185781497, 8667.0, 4731.668783185213, 4870.09903167915, 4970.15507363749, 5025.095482813055, 5121.8719532012, 3449.534312867731, 3494.353544594258, 3496.615372309044, 3499.580050393969, 3513.191965847818, 634.5304474688697, 646.2213033294962, 653.7025653327725, 654.7119267522274, 655.632845606462, 689.486332682155, 841.7811369044092, 843.1652663862732, 853.5732133933034, 878.2227728460358, 9174.770630734152, 9249.398789078688, 9339.252859771203, 9339.533023348806, 9341.626334946526, 695.4158506854267, 782.5539442517824, 830.4602008694276, 831.2975535672347, 838.0822998816286, 4350.695451318441, 4362.9781851091175, 4391.363252328459, 4603.194440972817, 4767.856964291077, 69322.0, 69931.65034174797, 70113.29886701067, 70118.0, 70334.29665703277, 51708.48291517112, 53486.7325663377, 54107.18839217415, 54204.45795542073, 54268.45731542634, 54589.454105459234, 54855.45144548583, 55264.17103743447, 55282.0, 55284.44715552954, 10464.424456654653, 10548.683539493828, 10573.52419141156, 10621.522031508446, 10784.514696838503, 39585.0, 39598.0, 40189.79905100456, 40977.0, 41290.38064429096, 46803.29795053145, 50423.0, 51472.0, 52223.0, 53246.73376633092, 13088.0, 13408.128471649312, 13426.932865335611, 13479.797803032767, 13607.523736669169, 13535.255560944242, 14193.716125677634, 14399.496017639332, 14726.631834203801, 14868.776968345268, 12334.32161231105, 12373.195742276723, 12414.193077449936, 12909.870901290868, 12932.676683082998, 12866.35668216604, 12897.871021289668, 13127.277999710108, 13252.138610990254, 13712.93143534276, 12988.90703586619, 13029.804552931524, 13487.730245395234, 13492.797608035691, 13724.862751372759, 11458.0, 11927.582534611247, 11936.224145430866, 12150.696232594255, 12216.694582635506, 10746.785064298827, 11039.253121157979, 11115.777684446104, 11450.656480305604, 11620.186586939171], "value": 7220.895196605077, "unit": "score"}], "name": "dromaeo_css", "value": 7546.367236843376, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 110.0, 111.0, 110.0, 112.0, 104.0, 110.0, 108.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 164.0, 182.0, 135.0, 155.0, 152.0, 131.0, 179.0, 126.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 159.0, 162.0, 163.0, 164.0, 161.0, 159.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 177.0, 74.0, 76.0, 76.0, 73.0, 151.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 151.0, 92.0, 93.0, 92.0, 145.0, 92.0, 91.0, 152.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 116.0, 116.0, 116.0, 117.0, 118.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 147.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 55.0, 55.0, 56.0, 75.0, 52.0, 52.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 56.0, 58.0, 57.0, 57.0, 57.0, 58.0, 58.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 75.0, 73.0, 71.0, 73.0, 72.0, 72.0, 72.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 113.0, 112.0, 111.0, 115.0, 109.0, 109.0, 108.0, 127.0, 112.0], "value": 113.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 162.0, 162.0, 164.0, 154.0, 155.0, 152.0, 155.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 69.0, 67.0, 66.0, 66.0, 65.0, 65.0, 69.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1505.0000000000002, "alertThreshold": 2.0}]} 20:19:39 INFO - Return code: 0 20:19:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:19:39 ERROR - # TBPL SUCCESS # 20:19:39 INFO - Running post-action listener: _resource_record_post_action 20:19:39 INFO - Running post-run listener: _resource_record_post_run 20:19:40 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 7553024; Write bytes: 358522880; Read time: 984; Write time: 366800 20:19:40 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 13455360; Read time: 0; Write time: 1008 20:19:40 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 5791744; Write bytes: 343113728; Read time: 904; Write time: 365580 20:19:40 INFO - Running post-run listener: _upload_blobber_files 20:19:40 INFO - Blob upload gear active. 20:19:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:19:40 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 20:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:19:40 INFO - (blobuploader) - INFO - Open directory for files ... 20:19:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:19:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:19:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:41 INFO - (blobuploader) - INFO - Done attempting. 20:19:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:19:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:19:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:42 INFO - (blobuploader) - INFO - Done attempting. 20:19:42 INFO - (blobuploader) - INFO - Iteration through files over. 20:19:42 INFO - Return code: 0 20:19:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:19:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:19:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4d4d0e1dbcc7a9914c1a83b8771ecf135d434c36084a59d3a4f03ba50a4eeb2fffaa8c38b5c96822ccb11519f079cdd6887a0e6f2c512369906981642fc852b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae0253ce7cb70653489c3e04fc3be29613956390abe74b5cb73b0d9d7b0b859cb0dc5ec350ec0e81acc35b281be0cb276cb99fb9d96f240f0965b31bc7332449"} 20:19:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:19:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:19:42 INFO - Contents: 20:19:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4d4d0e1dbcc7a9914c1a83b8771ecf135d434c36084a59d3a4f03ba50a4eeb2fffaa8c38b5c96822ccb11519f079cdd6887a0e6f2c512369906981642fc852b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae0253ce7cb70653489c3e04fc3be29613956390abe74b5cb73b0d9d7b0b859cb0dc5ec350ec0e81acc35b281be0cb276cb99fb9d96f240f0965b31bc7332449"} 20:19:42 INFO - Running post-run listener: copy_logs_to_upload_dir 20:19:42 INFO - Copying logs to upload dir... 20:19:42 INFO - mkdir: /builds/slave/test/build/upload/logs 20:19:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.732743 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-03 20:19:42.415344) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 20:19:42.419089) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4d4d0e1dbcc7a9914c1a83b8771ecf135d434c36084a59d3a4f03ba50a4eeb2fffaa8c38b5c96822ccb11519f079cdd6887a0e6f2c512369906981642fc852b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae0253ce7cb70653489c3e04fc3be29613956390abe74b5cb73b0d9d7b0b859cb0dc5ec350ec0e81acc35b281be0cb276cb99fb9d96f240f0965b31bc7332449"} build_url:https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/O_lZRqZFSxGOTq7yEhXfNQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4d4d0e1dbcc7a9914c1a83b8771ecf135d434c36084a59d3a4f03ba50a4eeb2fffaa8c38b5c96822ccb11519f079cdd6887a0e6f2c512369906981642fc852b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae0253ce7cb70653489c3e04fc3be29613956390abe74b5cb73b0d9d7b0b859cb0dc5ec350ec0e81acc35b281be0cb276cb99fb9d96f240f0965b31bc7332449"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 20:19:42.444416) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 20:19:42.444718) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467599954.429324-1073429725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 20:19:42.527264) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 20:19:42.527574) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 20:19:42.527915) ========= ========= Total master_lag: 0.18 =========