builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1462406765.75 results: success (0) buildid: 20160504163847 builduid: 3dfc009177984d64bf0762f4f117e93f revision: 989b5ce5f7cf848a8dcacae1fab74388257b63eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:05.755559) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:05.756070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:05.756534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:05.778495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:05.778835) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-04 17:06:07-- 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% 39.7M=0s 2016-05-04 17:06:08 (39.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:05.884123) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:05.884643) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018237 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:05.936404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:05.936782) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 989b5ce5f7cf848a8dcacae1fab74388257b63eb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 989b5ce5f7cf848a8dcacae1fab74388257b63eb --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=82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-04 17:06:08,146 truncating revision to first 12 chars 2016-05-04 17:06:08,146 Setting DEBUG logging. 2016-05-04 17:06:08,147 attempt 1/10 2016-05-04 17:06:08,147 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/989b5ce5f7cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-04 17:06:08,410 unpacking tar archive at: fx-team-989b5ce5f7cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549934 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:06.501538) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:06.501875) ========= script_repo_revision: 989b5ce5f7cf848a8dcacae1fab74388257b63eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:06.502310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:06.502639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 17:06:06.513088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-04 17:06:06.513532) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:06:08 INFO - MultiFileLogger online at 20160504 17:06:08 in /builds/slave/test 17:06:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:06:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:06:08 INFO - {'append_to_log': False, 17:06:08 INFO - 'base_work_dir': '/builds/slave/test', 17:06:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:06:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:06:08 INFO - 'branch': 'Fx-Team-Non-PGO', 17:06:08 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:08 INFO - 'config_files': ('talos/linux_config.py',), 17:06:08 INFO - 'default_actions': ('clobber', 17:06:08 INFO - 'read-buildbot-config', 17:06:08 INFO - 'download-and-extract', 17:06:08 INFO - 'populate-webroot', 17:06:08 INFO - 'create-virtualenv', 17:06:08 INFO - 'install', 17:06:08 INFO - 'run-tests'), 17:06:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:08 INFO - 'download_minidump_stackwalk': True, 17:06:08 INFO - 'download_symbols': 'ondemand', 17:06:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:08 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:08 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:08 INFO - 'installer_path': 'installer.exe', 17:06:08 INFO - 'log_level': 'info', 17:06:08 INFO - 'log_name': 'talos', 17:06:08 INFO - 'log_to_console': True, 17:06:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:06:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:06:08 INFO - 'opt_config_files': (), 17:06:08 INFO - 'pip_index': False, 17:06:08 INFO - 'sps_profile': False, 17:06:08 INFO - 'sps_profile_interval': 0, 17:06:08 INFO - 'suite': 'dromaeojs', 17:06:08 INFO - 'system_bits': '32', 17:06:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:08 INFO - 'title': 'talos-linux64-ix-066', 17:06:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:08 INFO - 'use_talos_json': True, 17:06:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:06:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:08 INFO - 'work_dir': 'build'} 17:06:08 INFO - ##### 17:06:08 INFO - ##### Running clobber step. 17:06:08 INFO - ##### 17:06:08 INFO - Running pre-action listener: _resource_record_pre_action 17:06:08 INFO - Running main action method: clobber 17:06:08 INFO - rmtree: /builds/slave/test/build 17:06:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:06:09 INFO - Running post-action listener: _resource_record_post_action 17:06:09 INFO - ##### 17:06:09 INFO - ##### Running read-buildbot-config step. 17:06:09 INFO - ##### 17:06:09 INFO - Running pre-action listener: _resource_record_pre_action 17:06:09 INFO - Running main action method: read_buildbot_config 17:06:09 INFO - Using buildbot properties: 17:06:09 INFO - { 17:06:09 INFO - "project": "", 17:06:09 INFO - "product": "firefox", 17:06:09 INFO - "script_repo_revision": "production", 17:06:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:06:09 INFO - "repository": "", 17:06:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:06:09 INFO - "buildid": "20160504163847", 17:06:09 INFO - "pgo_build": "False", 17:06:09 INFO - "basedir": "/builds/slave/test", 17:06:09 INFO - "buildnumber": 1725, 17:06:09 INFO - "slavename": "talos-linux64-ix-066", 17:06:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:06:09 INFO - "platform": "ubuntu64_hw", 17:06:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:06:09 INFO - "branch": "fx-team", 17:06:09 INFO - "repo_path": "integration/fx-team", 17:06:09 INFO - "revision": "989b5ce5f7cf848a8dcacae1fab74388257b63eb", 17:06:09 INFO - "stage_platform": "linux64", 17:06:09 INFO - "builduid": "3dfc009177984d64bf0762f4f117e93f", 17:06:09 INFO - "slavebuilddir": "test" 17:06:09 INFO - } 17:06:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:06:09 INFO - Running post-action listener: _resource_record_post_action 17:06:09 INFO - ##### 17:06:09 INFO - ##### Running download-and-extract step. 17:06:09 INFO - ##### 17:06:09 INFO - Running pre-action listener: _resource_record_pre_action 17:06:09 INFO - Running main action method: download_and_extract 17:06:09 INFO - mkdir: /builds/slave/test/build/tests 17:06:09 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')]} 17:06:09 INFO - https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:06:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:06:11 INFO - Downloaded 1361 bytes. 17:06:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:06:11 INFO - Using the following test package requirements: 17:06:11 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:11 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:06:11 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:06:11 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:11 INFO - u'jsshell-linux-x86_64.zip'], 17:06:11 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:06:11 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:11 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:06:11 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:06:11 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:06:11 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:06:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:11 INFO - https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:06:24 INFO - Downloaded 22307347 bytes. 17:06:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:06:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:06:25 INFO - Return code: 0 17:06:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:06:25 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')]} 17:06:25 INFO - https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:06:26 INFO - Downloaded 22307347 bytes. 17:06:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:06:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:06:28 INFO - Return code: 0 17:06: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')]} 17:06:28 INFO - https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:06:29 INFO - Downloaded 10840152 bytes. 17:06:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:06:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:06:29 INFO - Return code: 0 17:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:29 INFO - https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:06:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:06:30 INFO - Downloaded 54867311 bytes. 17:06:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:30 INFO - mkdir: /builds/slave/test/properties 17:06:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:30 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:30 INFO - Contents: 17:06:30 INFO - build_url:https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:06:31 INFO - Running post-action listener: _resource_record_post_action 17:06:31 INFO - Running post-action listener: set_extra_try_arguments 17:06:31 INFO - ##### 17:06:31 INFO - ##### Running populate-webroot step. 17:06:31 INFO - ##### 17:06:31 INFO - Running pre-action listener: _resource_record_pre_action 17:06:31 INFO - Running main action method: populate_webroot 17:06:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:31 INFO - '--tppagecycles', 17:06:31 INFO - '7'], 17:06:31 INFO - 'tests': ['tsvgm']}}, 17:06:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:06:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:06:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:06:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:06:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:06:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:31 INFO - 'talos_options': ['--disable-e10s'], 17:06:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:31 INFO - 'talos_options': ['--disable-e10s'], 17:06:31 INFO - 'tests': ['damp', 'tps']}, 17:06:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:31 INFO - 'tests': ['damp', 'tps']}, 17:06:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:06:31 INFO - 'tests': ['dromaeo_dom']}, 17:06:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:06:31 INFO - 'tests': ['a11yr', 17:06:31 INFO - 'ts_paint', 17:06:31 INFO - 'tpaint', 17:06:31 INFO - 'sessionrestore', 17:06:31 INFO - 'sessionrestore_no_auto_restore', 17:06:31 INFO - 'tabpaint']}, 17:06:31 INFO - 'other-e10s': {'tests': ['a11yr', 17:06:31 INFO - 'ts_paint', 17:06:31 INFO - 'tpaint', 17:06:31 INFO - 'sessionrestore', 17:06:31 INFO - 'sessionrestore_no_auto_restore', 17:06:31 INFO - 'tabpaint']}, 17:06:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:06:31 INFO - 'ts_paint', 17:06:31 INFO - 'tpaint', 17:06:31 INFO - 'sessionrestore', 17:06:31 INFO - 'sessionrestore_no_auto_restore', 17:06:31 INFO - 'tabpaint']}, 17:06:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:06:31 INFO - 'ts_paint', 17:06:31 INFO - 'tpaint', 17:06:31 INFO - 'sessionrestore', 17:06:31 INFO - 'sessionrestore_no_auto_restore', 17:06:31 INFO - 'tabpaint']}, 17:06:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:06:31 INFO - 'tests': ['a11yr', 17:06:31 INFO - 'ts_paint', 17:06:31 INFO - 'tpaint', 17:06:31 INFO - 'sessionrestore', 17:06:31 INFO - 'sessionrestore_no_auto_restore', 17:06:31 INFO - 'tabpaint']}, 17:06:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:06:31 INFO - 'tests': ['a11yr', 17:06:31 INFO - 'ts_paint', 17:06:31 INFO - 'tpaint', 17:06:31 INFO - 'sessionrestore', 17:06:31 INFO - 'sessionrestore_no_auto_restore', 17:06:31 INFO - 'tabpaint']}, 17:06:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:06:31 INFO - 'tests': ['tsvgx', 17:06:31 INFO - 'tsvgr_opacity', 17:06:31 INFO - 'tart', 17:06:31 INFO - 'tscrollx', 17:06:31 INFO - 'cart']}, 17:06:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:06:31 INFO - 'tsvgr_opacity', 17:06:31 INFO - 'tart', 17:06:31 INFO - 'tscrollx', 17:06:31 INFO - 'cart']}, 17:06:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:31 INFO - 'talos_options': ['--disable-e10s'], 17:06:31 INFO - 'tests': ['tp5o']}, 17:06:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:31 INFO - 'tests': ['tp5o']}, 17:06:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:31 INFO - 'talos_options': ['--disable-e10s', 17:06:31 INFO - '--xperf_path', 17:06:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:31 INFO - 'tests': ['tp5n']}, 17:06:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:31 INFO - 'talos_options': ['--xperf_path', 17:06:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:31 INFO - 'tests': ['tp5n']}}, 17:06:31 INFO - 'talos.zip': {'path': '', 17:06:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:31 INFO - Running post-action listener: _resource_record_post_action 17:06:31 INFO - ##### 17:06:31 INFO - ##### Running create-virtualenv step. 17:06:31 INFO - ##### 17:06:31 INFO - Running pre-action listener: _resource_record_pre_action 17:06:31 INFO - Running main action method: create_virtualenv 17:06:31 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:31 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 17:06:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:31 INFO - Using real prefix '/usr' 17:06:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:34 INFO - Installing pip.................done. 17:06:34 INFO - Return code: 0 17:06:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f12addc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2446410>, '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 0x2447310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24477a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', '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 17:06: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', 'pip>=1.5'] in /builds/slave/test/build 17:06: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 pip>=1.5 17:06:34 INFO - Using env: {'DISPLAY': ':0', 17:06:34 INFO - 'HOME': '/home/cltbld', 17:06:34 INFO - 'LANG': 'en_US.UTF-8', 17:06:34 INFO - 'LANGUAGE': 'en_US:en', 17:06:34 INFO - 'LOGNAME': 'cltbld', 17:06:34 INFO - 'MAIL': '/var/mail/cltbld', 17:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:34 INFO - 'MOZ_NO_REMOTE': '1', 17:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:34 INFO - 'NO_EM_RESTART': '1', 17:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:34 INFO - 'PWD': '/builds/slave/test', 17:06:34 INFO - 'SHELL': '/bin/bash', 17:06:34 INFO - 'SHLVL': '1', 17:06:34 INFO - 'TERM': 'linux', 17:06:34 INFO - 'TMOUT': '86400', 17:06:34 INFO - 'USER': 'cltbld', 17:06:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', 17:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:34 INFO - '_': '/tools/buildbot/bin/python'} 17:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:34 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 17:06:34 INFO - Cleaning up... 17:06:34 INFO - Return code: 0 17:06:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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', '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 0x7f12addc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2446410>, '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 0x2447310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24477a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', '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 17:06: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', 'psutil>=0.7.1'] in /builds/slave/test/build 17:06: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 psutil>=0.7.1 17:06:34 INFO - Using env: {'DISPLAY': ':0', 17:06:34 INFO - 'HOME': '/home/cltbld', 17:06:34 INFO - 'LANG': 'en_US.UTF-8', 17:06:34 INFO - 'LANGUAGE': 'en_US:en', 17:06:34 INFO - 'LOGNAME': 'cltbld', 17:06:34 INFO - 'MAIL': '/var/mail/cltbld', 17:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:34 INFO - 'MOZ_NO_REMOTE': '1', 17:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:34 INFO - 'NO_EM_RESTART': '1', 17:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:34 INFO - 'PWD': '/builds/slave/test', 17:06:34 INFO - 'SHELL': '/bin/bash', 17:06:34 INFO - 'SHLVL': '1', 17:06:34 INFO - 'TERM': 'linux', 17:06:34 INFO - 'TMOUT': '86400', 17:06:34 INFO - 'USER': 'cltbld', 17:06:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', 17:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:34 INFO - '_': '/tools/buildbot/bin/python'} 17:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:34 INFO - Downloading/unpacking psutil>=0.7.1 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:36 INFO - Installing collected packages: psutil 17:06:36 INFO - Running setup.py install for psutil 17:06:36 INFO - building 'psutil._psutil_linux' extension 17:06:36 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 17:06:36 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 17:06:36 INFO - building 'psutil._psutil_posix' extension 17:06:36 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 17:06:36 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 17:06:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:37 INFO - Successfully installed psutil 17:06:37 INFO - Cleaning up... 17:06:37 INFO - Return code: 0 17:06:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f12addc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2446410>, '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 0x2447310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24477a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', '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 17:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:06:37 INFO - Using env: {'DISPLAY': ':0', 17:06:37 INFO - 'HOME': '/home/cltbld', 17:06:37 INFO - 'LANG': 'en_US.UTF-8', 17:06:37 INFO - 'LANGUAGE': 'en_US:en', 17:06:37 INFO - 'LOGNAME': 'cltbld', 17:06:37 INFO - 'MAIL': '/var/mail/cltbld', 17:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:37 INFO - 'MOZ_NO_REMOTE': '1', 17:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:37 INFO - 'NO_EM_RESTART': '1', 17:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:37 INFO - 'PWD': '/builds/slave/test', 17:06:37 INFO - 'SHELL': '/bin/bash', 17:06:37 INFO - 'SHLVL': '1', 17:06:37 INFO - 'TERM': 'linux', 17:06:37 INFO - 'TMOUT': '86400', 17:06:37 INFO - 'USER': 'cltbld', 17:06:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', 17:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:37 INFO - '_': '/tools/buildbot/bin/python'} 17:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:06:39 INFO - Installing collected packages: mozsystemmonitor 17:06:39 INFO - Running setup.py install for mozsystemmonitor 17:06:39 INFO - Successfully installed mozsystemmonitor 17:06:39 INFO - Cleaning up... 17:06:39 INFO - Return code: 0 17:06:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:39 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 0x7f12addc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2446410>, '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 0x2447310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24477a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', '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 17:06:39 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 17:06:39 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 17:06:39 INFO - Using env: {'DISPLAY': ':0', 17:06:39 INFO - 'HOME': '/home/cltbld', 17:06:39 INFO - 'LANG': 'en_US.UTF-8', 17:06:39 INFO - 'LANGUAGE': 'en_US:en', 17:06:39 INFO - 'LOGNAME': 'cltbld', 17:06:39 INFO - 'MAIL': '/var/mail/cltbld', 17:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:39 INFO - 'MOZ_NO_REMOTE': '1', 17:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:39 INFO - 'NO_EM_RESTART': '1', 17:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:39 INFO - 'PWD': '/builds/slave/test', 17:06:39 INFO - 'SHELL': '/bin/bash', 17:06:39 INFO - 'SHLVL': '1', 17:06:39 INFO - 'TERM': 'linux', 17:06:39 INFO - 'TMOUT': '86400', 17:06:39 INFO - 'USER': 'cltbld', 17:06:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', 17:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:39 INFO - '_': '/tools/buildbot/bin/python'} 17:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:39 INFO - Downloading/unpacking blobuploader==1.2.4 17:06:39 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 17:06:39 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 17:06:39 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 17:06:39 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 17:06:39 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 17:06:39 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 17:06:41 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:41 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 17:06:41 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 17:06:41 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 17:06:41 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 17:06:41 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 17:06:41 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 17:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:06:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:41 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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:42 INFO - Downloading docopt-0.6.1.tar.gz 17:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:42 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:42 INFO - Running setup.py install for blobuploader 17:06:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:06:42 INFO - Running setup.py install for requests 17:06:42 INFO - Running setup.py install for docopt 17:06:42 INFO - Successfully installed blobuploader requests docopt 17:06:42 INFO - Cleaning up... 17:06:42 INFO - Return code: 0 17:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:42 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 0x7f12addc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2446410>, '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 0x2447310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24477a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', '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 17:06:42 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 17:06:42 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 17:06:42 INFO - Using env: {'DISPLAY': ':0', 17:06:42 INFO - 'HOME': '/home/cltbld', 17:06:42 INFO - 'LANG': 'en_US.UTF-8', 17:06:42 INFO - 'LANGUAGE': 'en_US:en', 17:06:42 INFO - 'LOGNAME': 'cltbld', 17:06:42 INFO - 'MAIL': '/var/mail/cltbld', 17:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:42 INFO - 'MOZ_NO_REMOTE': '1', 17:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:42 INFO - 'NO_EM_RESTART': '1', 17:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:42 INFO - 'PWD': '/builds/slave/test', 17:06:42 INFO - 'SHELL': '/bin/bash', 17:06:42 INFO - 'SHLVL': '1', 17:06:42 INFO - 'TERM': 'linux', 17:06:42 INFO - 'TMOUT': '86400', 17:06:42 INFO - 'USER': 'cltbld', 17:06:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', 17:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:42 INFO - '_': '/tools/buildbot/bin/python'} 17:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:43 INFO - Running setup.py (path:/tmp/pip-qFtN_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:43 INFO - Running setup.py (path:/tmp/pip-uI0Wzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:43 INFO - Running setup.py (path:/tmp/pip-bOIvqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:43 INFO - Running setup.py (path:/tmp/pip-FRPdT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:43 INFO - Running setup.py (path:/tmp/pip-hcE4Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:43 INFO - Running setup.py (path:/tmp/pip-qzK472-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:43 INFO - Running setup.py (path:/tmp/pip-NCcQqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:43 INFO - Running setup.py (path:/tmp/pip-rFqVgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:43 INFO - Running setup.py (path:/tmp/pip-WoDFsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:43 INFO - Running setup.py (path:/tmp/pip-dWpdlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:43 INFO - Running setup.py (path:/tmp/pip-uyy2iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:43 INFO - Running setup.py (path:/tmp/pip-9qrRW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:43 INFO - Running setup.py (path:/tmp/pip-qjsc0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:44 INFO - Running setup.py (path:/tmp/pip-LZnjMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:44 INFO - Running setup.py (path:/tmp/pip-q5zrXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:44 INFO - Running setup.py (path:/tmp/pip-8qWOyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:44 INFO - Running setup.py (path:/tmp/pip-QehKao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:44 INFO - Running setup.py install for manifestparser 17:06:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:06:44 INFO - Running setup.py install for mozcrash 17:06:44 INFO - Running setup.py install for mozdebug 17:06:44 INFO - Running setup.py install for mozdevice 17:06:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:06:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:06:44 INFO - Running setup.py install for mozfile 17:06:44 INFO - Running setup.py install for mozhttpd 17:06:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:06:44 INFO - Running setup.py install for mozinfo 17:06:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Running setup.py install for mozInstall 17:06:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Running setup.py install for mozleak 17:06:45 INFO - Running setup.py install for mozlog 17:06:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Running setup.py install for moznetwork 17:06:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Running setup.py install for mozprocess 17:06:45 INFO - Running setup.py install for mozprofile 17:06:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Running setup.py install for mozrunner 17:06:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:06:45 INFO - Running setup.py install for mozscreenshot 17:06:45 INFO - Running setup.py install for moztest 17:06:45 INFO - Running setup.py install for mozversion 17:06:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:06:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:46 INFO - Cleaning up... 17:06:46 INFO - Return code: 0 17:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:46 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 0x7f12addc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2446410>, '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 0x2447310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24477a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', '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 17:06:46 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 17:06:46 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 17:06:46 INFO - Using env: {'DISPLAY': ':0', 17:06:46 INFO - 'HOME': '/home/cltbld', 17:06:46 INFO - 'LANG': 'en_US.UTF-8', 17:06:46 INFO - 'LANGUAGE': 'en_US:en', 17:06:46 INFO - 'LOGNAME': 'cltbld', 17:06:46 INFO - 'MAIL': '/var/mail/cltbld', 17:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:46 INFO - 'MOZ_NO_REMOTE': '1', 17:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:46 INFO - 'NO_EM_RESTART': '1', 17:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:46 INFO - 'PWD': '/builds/slave/test', 17:06:46 INFO - 'SHELL': '/bin/bash', 17:06:46 INFO - 'SHLVL': '1', 17:06:46 INFO - 'TERM': 'linux', 17:06:46 INFO - 'TMOUT': '86400', 17:06:46 INFO - 'USER': 'cltbld', 17:06:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', 17:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:46 INFO - '_': '/tools/buildbot/bin/python'} 17:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:46 INFO - Running setup.py (path:/tmp/pip-ondQCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:46 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)) 17:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:46 INFO - Running setup.py (path:/tmp/pip-tLPxfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:46 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)) 17:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:46 INFO - Running setup.py (path:/tmp/pip-SpIogv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:46 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)) 17:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:46 INFO - Running setup.py (path:/tmp/pip-vYqyOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:46 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)) 17:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:46 INFO - Running setup.py (path:/tmp/pip-QviGGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:46 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)) 17:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:46 INFO - Running setup.py (path:/tmp/pip-ZyyzP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:46 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)) 17:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:46 INFO - Running setup.py (path:/tmp/pip-lI5Fll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:46 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)) 17:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:46 INFO - Running setup.py (path:/tmp/pip-oqWwMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:46 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)) 17:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:46 INFO - Running setup.py (path:/tmp/pip-5yahWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:46 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)) 17:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:46 INFO - Running setup.py (path:/tmp/pip-IJDP1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:47 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)) 17:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:47 INFO - Running setup.py (path:/tmp/pip-yaeq5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:47 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)) 17:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:47 INFO - Running setup.py (path:/tmp/pip-klzLky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:47 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)) 17:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:47 INFO - Running setup.py (path:/tmp/pip-wxzGXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:47 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)) 17:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:47 INFO - Running setup.py (path:/tmp/pip-ZydJcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:47 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)) 17:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:47 INFO - Running setup.py (path:/tmp/pip-zd_6uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:47 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)) 17:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:47 INFO - Running setup.py (path:/tmp/pip-RA8Jb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:47 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)) 17:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:47 INFO - Running setup.py (path:/tmp/pip-ADTlx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:47 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)) 17:06:47 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)) 17:06:47 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)) 17:06:47 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)) 17:06:47 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)) 17:06:47 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)) 17:06:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:49 INFO - Downloading blessings-1.6.tar.gz 17:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:06:49 INFO - Installing collected packages: blessings 17:06:49 INFO - Running setup.py install for blessings 17:06:49 INFO - Successfully installed blessings 17:06:49 INFO - Cleaning up... 17:06:49 INFO - Return code: 0 17:06:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:49 INFO - Reading from file tmpfile_stdout 17:06:49 INFO - Current package versions: 17:06:49 INFO - argparse == 1.2.1 17:06:49 INFO - blessings == 1.6 17:06:49 INFO - blobuploader == 1.2.4 17:06:49 INFO - docopt == 0.6.1 17:06:49 INFO - manifestparser == 1.1 17:06:49 INFO - mozInstall == 1.12 17:06:49 INFO - mozcrash == 0.17 17:06:49 INFO - mozdebug == 0.1 17:06:49 INFO - mozdevice == 0.48 17:06:49 INFO - mozfile == 1.2 17:06:49 INFO - mozhttpd == 0.7 17:06:49 INFO - mozinfo == 0.9 17:06:49 INFO - mozleak == 0.1 17:06:49 INFO - mozlog == 3.1 17:06:49 INFO - moznetwork == 0.27 17:06:49 INFO - mozprocess == 0.22 17:06:49 INFO - mozprofile == 0.28 17:06:49 INFO - mozrunner == 6.11 17:06:49 INFO - mozscreenshot == 0.1 17:06:49 INFO - mozsystemmonitor == 0.0 17:06:49 INFO - moztest == 0.7 17:06:49 INFO - mozversion == 1.4 17:06:49 INFO - psutil == 3.1.1 17:06:49 INFO - requests == 1.2.3 17:06:49 INFO - wsgiref == 0.1.2 17:06:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:49 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 0x7f12addc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2446410>, '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 0x2447310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24477a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', '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 17:06:49 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 17:06:49 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 17:06:49 INFO - Using env: {'DISPLAY': ':0', 17:06:49 INFO - 'HOME': '/home/cltbld', 17:06:49 INFO - 'LANG': 'en_US.UTF-8', 17:06:49 INFO - 'LANGUAGE': 'en_US:en', 17:06:49 INFO - 'LOGNAME': 'cltbld', 17:06:49 INFO - 'MAIL': '/var/mail/cltbld', 17:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:49 INFO - 'MOZ_NO_REMOTE': '1', 17:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:49 INFO - 'NO_EM_RESTART': '1', 17:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:49 INFO - 'PWD': '/builds/slave/test', 17:06:49 INFO - 'SHELL': '/bin/bash', 17:06:49 INFO - 'SHLVL': '1', 17:06:49 INFO - 'TERM': 'linux', 17:06:49 INFO - 'TMOUT': '86400', 17:06:49 INFO - 'USER': 'cltbld', 17:06:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', 17:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:49 INFO - '_': '/tools/buildbot/bin/python'} 17:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:50 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)) 17:06:50 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)) 17:06:50 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)) 17:06:50 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)) 17:06:50 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)) 17:06:50 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)) 17:06:50 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)) 17:06:50 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)) 17:06:50 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)) 17:06:50 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)) 17:06:50 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)) 17:06:50 INFO - Cleaning up... 17:06:50 INFO - Return code: 0 17:06:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:06:50 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')]} 17:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:50 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')]} 17:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:50 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 0x7f12addc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2446410>, '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 0x2447310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24477a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', '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 17:06:50 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 17:06:50 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 17:06:50 INFO - Using env: {'DISPLAY': ':0', 17:06:50 INFO - 'HOME': '/home/cltbld', 17:06:50 INFO - 'LANG': 'en_US.UTF-8', 17:06:50 INFO - 'LANGUAGE': 'en_US:en', 17:06:50 INFO - 'LOGNAME': 'cltbld', 17:06:50 INFO - 'MAIL': '/var/mail/cltbld', 17:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:50 INFO - 'MOZ_NO_REMOTE': '1', 17:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:50 INFO - 'NO_EM_RESTART': '1', 17:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:50 INFO - 'PWD': '/builds/slave/test', 17:06:50 INFO - 'SHELL': '/bin/bash', 17:06:50 INFO - 'SHLVL': '1', 17:06:50 INFO - 'TERM': 'linux', 17:06:50 INFO - 'TMOUT': '86400', 17:06:50 INFO - 'USER': 'cltbld', 17:06:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', 17:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:50 INFO - '_': '/tools/buildbot/bin/python'} 17:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:50 INFO - Downloading/unpacking jsonschema 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:06:52 INFO - Downloading/unpacking functools32 (from jsonschema) 17:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:52 INFO - Downloading functools32-3.2.3-2.tar.gz 17:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:06:52 INFO - warning: no files found matching '*.txt' 17:06:52 INFO - no previously-included directories found matching 'build' 17:06:52 INFO - no previously-included directories found matching 'dist' 17:06:52 INFO - no previously-included directories found matching '.git*' 17:06:52 INFO - Installing collected packages: jsonschema, functools32 17:06:52 INFO - Running setup.py install for functools32 17:06:52 INFO - warning: no files found matching '*.txt' 17:06:52 INFO - no previously-included directories found matching 'build' 17:06:52 INFO - no previously-included directories found matching 'dist' 17:06:52 INFO - no previously-included directories found matching '.git*' 17:06:52 INFO - Successfully installed jsonschema functools32 17:06:52 INFO - Cleaning up... 17:06:52 INFO - Return code: 0 17:06:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:06:52 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')]} 17:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:52 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')]} 17:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:52 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 0x7f12addc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2446410>, '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 0x2447310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24477a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', '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 17:06:52 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 17:06:52 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 17:06:52 INFO - Using env: {'DISPLAY': ':0', 17:06:52 INFO - 'HOME': '/home/cltbld', 17:06:52 INFO - 'LANG': 'en_US.UTF-8', 17:06:52 INFO - 'LANGUAGE': 'en_US:en', 17:06:52 INFO - 'LOGNAME': 'cltbld', 17:06:52 INFO - 'MAIL': '/var/mail/cltbld', 17:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:52 INFO - 'MOZ_NO_REMOTE': '1', 17:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:52 INFO - 'NO_EM_RESTART': '1', 17:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:52 INFO - 'PWD': '/builds/slave/test', 17:06:52 INFO - 'SHELL': '/bin/bash', 17:06:52 INFO - 'SHLVL': '1', 17:06:52 INFO - 'TERM': 'linux', 17:06:52 INFO - 'TMOUT': '86400', 17:06:52 INFO - 'USER': 'cltbld', 17:06:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', 17:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:52 INFO - '_': '/tools/buildbot/bin/python'} 17:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:52 INFO - Downloading/unpacking flake8 17:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:06:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:06:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:06:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:06:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:06:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:06:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:06:55 INFO - no previously-included directories found matching 'docs/_build' 17:06:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:06:55 INFO - Running setup.py install for pep8 17:06:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:06:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:06:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:06:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:06:55 INFO - no previously-included directories found matching 'docs/_build' 17:06:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:06:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:06:55 INFO - Cleaning up... 17:06:55 INFO - Return code: 0 17:06:55 INFO - Running post-action listener: _resource_record_post_action 17:06:55 INFO - Running post-action listener: _start_resource_monitoring 17:06:55 INFO - Starting resource monitoring. 17:06:55 INFO - ##### 17:06:55 INFO - ##### Running install step. 17:06:55 INFO - ##### 17:06:55 INFO - Running pre-action listener: _resource_record_pre_action 17:06:55 INFO - Running main action method: install 17:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:55 INFO - Reading from file tmpfile_stdout 17:06:55 INFO - Detecting whether we're running mozinstall >=1.0... 17:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:06:56 INFO - Reading from file tmpfile_stdout 17:06:56 INFO - Output received: 17:06:56 INFO - Usage: mozinstall [options] installer 17:06:56 INFO - Options: 17:06:56 INFO - -h, --help show this help message and exit 17:06:56 INFO - -d DEST, --destination=DEST 17:06:56 INFO - Directory to install application into. [default: 17:06:56 INFO - "/builds/slave/test"] 17:06:56 INFO - --app=APP Application being installed. [default: firefox] 17:06:56 INFO - mkdir: /builds/slave/test/build/application 17:06:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:07:11 INFO - Reading from file tmpfile_stdout 17:07:11 INFO - Output received: 17:07:11 INFO - /builds/slave/test/build/application/firefox/firefox 17:07:11 INFO - Running post-action listener: _resource_record_post_action 17:07:11 INFO - ##### 17:07:11 INFO - ##### Running run-tests step. 17:07:11 INFO - ##### 17:07:11 INFO - Running pre-action listener: _resource_record_pre_action 17:07:11 INFO - Running main action method: run_tests 17:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:11 INFO - Python 2.7.3 17:07:11 INFO - Return code: 0 17:07:11 INFO - grabbing minidump binary from tooltool 17:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:11 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 0x2446410>, '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 0x2447310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24477a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:11 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 17:07:11 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 17:07:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:11 INFO - Return code: 0 17:07:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:07:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:07:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:07:12 INFO - Return code: 0 17:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 17:07:12 INFO - Using env: {'DISPLAY': ':0', 17:07:12 INFO - 'HOME': '/home/cltbld', 17:07:12 INFO - 'LANG': 'en_US.UTF-8', 17:07:12 INFO - 'LANGUAGE': 'en_US:en', 17:07:12 INFO - 'LOGNAME': 'cltbld', 17:07:12 INFO - 'MAIL': '/var/mail/cltbld', 17:07:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:12 INFO - 'MOZ_NO_REMOTE': '1', 17:07:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:12 INFO - 'NO_EM_RESTART': '1', 17:07:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:12 INFO - 'PWD': '/builds/slave/test', 17:07:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:12 INFO - 'SHELL': '/bin/bash', 17:07:12 INFO - 'SHLVL': '1', 17:07:12 INFO - 'TERM': 'linux', 17:07:12 INFO - 'TMOUT': '86400', 17:07:12 INFO - 'USER': 'cltbld', 17:07:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101', 17:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:12 INFO - '_': '/tools/buildbot/bin/python'} 17:07:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:07:13 INFO - mozversion application_buildid: 20160504163847 17:07:13 INFO - mozversion application_changeset: 989b5ce5f7cf848a8dcacae1fab74388257b63eb 17:07:13 INFO - mozversion application_display_name: Nightly 17:07:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:13 INFO - mozversion application_name: Firefox 17:07:13 INFO - mozversion application_remotingname: firefox 17:07:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:07:13 INFO - mozversion application_vendor: Mozilla 17:07:13 INFO - mozversion application_version: 49.0a1 17:07:13 INFO - mozversion platform_buildid: 20160504163847 17:07:13 INFO - mozversion platform_changeset: 989b5ce5f7cf848a8dcacae1fab74388257b63eb 17:07:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:07:13 INFO - mozversion platform_version: 49.0a1 17:07:13 INFO - using testdate: 1462406833 17:07:13 INFO - actual date: 1462406833 17:07:13 INFO - starting webserver on 'localhost:52362' 17:07:13 INFO - SUITE-START | Running 2 tests 17:07:13 INFO - TEST-START | dromaeo_css 17:07:13 INFO - operating with platform_type : linux_ 17:07:13 INFO - Initialising browser for dromaeo_css test... 17:07:13 INFO - TEST-INFO | started process 25029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCTyRzE/profile http://localhost:52362/getInfo.html) 17:07:17 INFO - PROCESS | 25029 | __metrics Screen width/height:1600/1200 17:07:17 INFO - PROCESS | 25029 | colorDepth:24 17:07:17 INFO - PROCESS | 25029 | Browser inner width/height: 1024/697 17:07:17 INFO - PROCESS | 25029 | __metrics 17:07:18 ERROR - PROCESS | 25029 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:07:19 INFO - TEST-INFO | 25029: exit 0 17:07:19 INFO - Browser initialized. 17:07:19 INFO - Running cycle 1/1 for dromaeo_css test... 17:07:19 INFO - TEST-INFO | started process 25110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCTyRzE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:31 INFO - PROCESS | 25110 | RSS: Main: 156323840 17:07:31 INFO - PROCESS | 25110 | 17:08:22 INFO - PROCESS | 25110 | 1462406902865 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] 17:10:34 INFO - PROCESS | 25110 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52362/tests/dromaeo/cssquery-ext.html) 17:10:35 INFO - PROCESS | 25110 | RSS: Main: 235683840 17:10:35 INFO - PROCESS | 25110 | 17:13:37 INFO - PROCESS | 25110 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-ext.html (next: http://localhost:52362/tests/dromaeo/cssquery-jquery.html) 17:13:38 INFO - PROCESS | 25110 | RSS: Main: 235307008 17:13:38 INFO - PROCESS | 25110 | 17:16:40 INFO - PROCESS | 25110 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52362/tests/dromaeo/cssquery-mootools.html) 17:16:40 INFO - PROCESS | 25110 | RSS: Main: 245149696 17:16:40 INFO - PROCESS | 25110 | 17:19:42 INFO - PROCESS | 25110 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52362/tests/dromaeo/cssquery-prototype.html) 17:19:43 INFO - PROCESS | 25110 | RSS: Main: 239894528 17:19:43 INFO - PROCESS | 25110 | 17:22:46 INFO - PROCESS | 25110 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52362/tests/dromaeo/cssquery-yui.html) 17:22:47 INFO - PROCESS | 25110 | RSS: Main: 218050560 17:22:47 INFO - PROCESS | 25110 | 17:25:49 INFO - PROCESS | 25110 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-yui.html (next: http://localhost:52362/tests/dromaeo/cssquery-dojo.html) 17:25:50 INFO - PROCESS | 25110 | RSS: Main: 273719296 17:25:50 INFO - PROCESS | 25110 | 17:25:50 INFO - PROCESS | 25110 | __start_tp_report 17:25:50 INFO - PROCESS | 25110 | _x_x_mozilla_page_load 17:25:50 INFO - PROCESS | 25110 | _x_x_mozilla_page_load_details 17:25:50 INFO - PROCESS | 25110 | |i|pagename|runs| 17:25:50 INFO - PROCESS | 25110 | |0;dojo.html;2556.8721563921804;2602.8958841646336;2611.569091099969;2628.3691913940647;2641.788656907447;4521.276595744682;4544.977275113624;4568.474625418074;4569.223232050551;4626.190416677076;4605.976970115154;4631.212693842046;4665.300204969256;4725.810967561302;4736.265878788785;4246.065865509583;4250.957490425087;4279.679024073207;4313.935290970638;4460.754658493782;4342.413774140482;4370.912581748379;4395.604395604395;4397.428334316534;4436.622887054588;4221.324588065895;4232.470941132358;4242.172776308621;4306.849260275907;4314.374415709736;4291.678124140671;4308.439902812645;4312.180685669713;4316.568343165658;4357.1721372939355;4291.527931927517;4306.246406878784;4309.806058727365;4335.544767799367;4341.978290108561;4470.150671372428;4534.727916325031;4541.591256786905;4630.72215667061;4641.721496710208;4964;4969.453360130383;4972.105021096201;4978;5008.84973450797;5015.473375295578;5015.774290156952;5020.523050310215;5023.598112151019;5041.697498150123;4597.218472859622;4686.95313046872;4738.8341408050555;4742.644301677388;4743.762811859393;5070.822521211814;5114.28400023997;5115.769790359368;5117.283580298761;5118.129917913963;4769.73766442842;4914.140025495595;4918.655694101379;4919.2129259318335;4958.975205124024;4866.440359358719;4889.168841296988;4919.311296418504;4951.183054795991;4963.925541116886;4906.386701662293;4908.460069392364;4914.631402644816;4919.803207871717;4967.90064198714;4800.687955282895;4878.390201224847;4890.853274401774;4894.67843682211;4943.332650092263;4216.725912815718;4222.155568886235;4223.387608796707;4246.4691913510815;4264.808083636244;3679.8528058877882;3724.1062145084984;3728.217074414349;3751;3773.3208022555655;4193.496780386373;4241.830326786956;4263.424437700871;4289.635380992589;4324.394584758136;5029.27075574047;5049.545540901337;5051.090803655304;5054.317667114892;5101.413337466165;4307.612314891675;4317.892052698708;4318.5033721121845;4321.67587430944;4368.737875727466;4446.110777844444;4453.153900758845;4523.140603285366;4528.615067719281;4564.0871825635;4710.882227944192;4726.834560790493;4738.715677059387;4754.144254034238;4781.976090119666;5014.724190169576;5020.071286811952;5022.096022715946;5034.924476132787;5080.314157588678;4587.4036375271;4689.882752931204;4730.952690473051;4775.952240477551;4790.377250957354;4892.657513973988;4907.631927605516;4920.72935988524;4932.30947667334;4969.130402179532;4911.68074075184;4987.202047672355;5005.62457815658;5007.649464537593;5052.242163675331;4772.308015337826;4831.130396528659;4889.266610008385;4913.066517361833;4925.605951523798;4825.855224343275;4826.203676393356;4845.49122342149;4861.270809378621;4902.117618828645;4591.678582499193;4739.47865734762;4767.523247675204;4770.308305295644;4836.588889944394;4898.681585696918;4934.506549345037;4939;4971.403431588088;4991.8752031198055;4738.739369334719;4791.808327666854;4793.832215872567;4817.975910120427;4839.2983017462975 17:25:50 INFO - PROCESS | 25110 | |1;ext.html;597.3906615252442;613.025289789235;623.940725631065;633.0188208277173;645.4803882874285;35495.2900941981;37281.81359093204;37320.62679373205;37447.81276093623;37478.063048423806;43128.353074703824;43708.3443748344;43796.12407751843;43860;43929.34105988413;7812.531248125117;8068.112507624186;8068.152843951389;8068.314193293548;8072.55600941948;7873.330766884822;7988.081370642363;8007.919920800776;8011.879821802678;8017.278444939954;7970.800729981739;8027.799305017363;8051.597420128999;8052.235037671441;8057.919420805775;7931.801704957365;7940.166282540308;7994.160613135595;8015.47899386538;8020.11778704342;7839.098503672037;7978.760637180894;8044.396670249755;8047.275745182962;8050.59747012647;39515.80242098771;39803;40150.397744033864;40207.7989610053;40245.79877100625;2931.193921671536;3000.219942814884;3113.2839446927333;3143.748500120008;3741.8316175772156;30152;30202.69797302043;30259.546106808415;30512.84743576268;30735;3135.937281254362;3145.2294187923876;3172.5558421820965;3191.824449655268;3246.2533617267923;247349.9999999982;248586;248638;249925;250188;42989.78505107454;57188.71405642945;57651.423485765445;57681.71159144177;57734.71132644394;51277.48722512727;53267.73366133145;53355.46644533583;53385;53414.7329263359;13120.540781072617;13180.406881690347;13337.999650026286;13385.330733463288;13564;8965.327600429993;9964.352317099365;10733.248672593;10840.29538080038;10869.293495922899;17611;17821.910890445466;17822.821771782375;17827.910860445616;17894.284228630968;5831.825045248649;5854.882902342015;5925.555583331267;5959.851003724942;6047.123167140828;857.648364170687;872.2455076358904;927.2165020557753;996.496769131584;1003.2174903575223;25727.48545029089;26211.868940655557;26272.73727262703;26308.473830523282;26491;993.9353941993747;1027.6505987964129;1037.699067270483;1041.796849614318;1055.8310670292717;14392.35234414454;14677.92661036688;14983.700325993419;15177.16525591081;15286.923565382102;339484;339535;343162;345482;345554;50528.494715053115;50907;51336.74331628318;51339.48660513422;51505.48494515007;1262.3940508555945;1287.7424515096832;1292.095533126815;1298.8831005209577;1317.571789168505;26820.731792681825;27371.178864634094;28649.856750716113;28793.280167995967;28934;49445.25832112449;50226.24660630167;50527;50554.49445505498;50682;325005;334352;336680;336989;337025;33110.337793244486;33725;37115.44326835046;37545;37657.81171094127;41693.37459938164;43419.782901085295;43522.34716479319;45300.77349613231;47120.057598848514;38521.22957540889;38969.610303896596;39130;39175;39756.801215993735;37820.62179378171;38507.80746096252;38549;38616.42075368816;38993.41509877411;38034;38791;38869.2226155481;38996.805015974736;39067.6093239064;32282.35435291328;34158.487622686174;34892.30215395627;34901.65098349086;35282.647173527934;25954.07680430328;26403.867980659972;26413.60379594346;26708;26798.5161928948 17:25:50 INFO - PROCESS | 25110 | |2;jquery.html;377.2737480350325;385.29298736817935;388.96888248940087;393.6240889950098;402.7945747668692;16021.999999999985;16631.41790037349;17325.91337043316;17357.30570777169;17379;17548.12259387032;17831.821681783178;18109.366172183974;18247.54381140472;18449.7232541512;5022.422421421537;5158.123119069767;5183.714895680736;5199.714015729133;5203.635745497817;3673.1184515716304;4552.567506086916;5914.260717410324;5918.911216331759;5933.792317268896;5690.829275121753;5862.677552734598;5914.585978981473;5919.17131601574;5943.078822782476;5806.738696758634;5889.1755154278435;5902.822915312548;5903.35063143054;5912.320083190445;5114.181730923072;5144.382674079135;5195.714235717034;5238.73806309683;5246.737663116829;21081;21342.359729207994;21638;21678.89160554203;21771.564568708538;1881.8588605854616;1994.9700754488695;2146.248812915467;2247.449374903159;2259.8757068361233;12884.355782210852;12983.675408114777;13032.869671303355;13091.738165236642;13631.182129072287;1685.6123091688858;1798.0650061967833;1816.3642725046127;1821.3898344054626;1933.6712758831034;67747;68873.65563172151;69640;69991;70821.6883733722;9851.113399794052;9917.603295868084;10074.798504030025;10121.898781012243;10272.537735801907;13877.306134693225;13939.512117076056;14012.579622611338;14067.71864562703;14073.225972571607;7167.605781682058;7356.816079597946;7360.2271761465345;7428.145763237297;7444.627768611548;6821.897671534931;6872.965635171792;6960.895586566206;6971.58170509771;6988.755393561302;6219.844503887349;6291.245050593867;6332.430081292706;6332.575170586673;6497.967510162419;1825.3063835742332;1843.9539011524819;1846.270723064382;1857.8142185781585;1875.6436277107307;826.4173757501068;874.9737507874773;930.8138372325427;989.8614194012844;1050.2700623067049;16589.17054147288;17376.65246695059;17418.23822515746;17529.561760955825;17699.469015929542;912.4479689787715;915.7573243090586;949.8005418861978;965.8213230552229;970.6457143142702;9735.805283894282;10172.898271017342;10175.08424241807;10192.796144077225;10260.067654240147;306214;311237;311702;314130;380241;48226.517734822904;50517;69044;74788;76130.61934690402;964.1804466203811;980.9950950245203;1003.7641154328727;1012.8531362952479;1020.3010937507831;11356.318620882774;15757.369705211662;16073.517794466185;16233.67532649364;16289.266982986032;32513.67486325201;35029.949101526996;37229;37487.43768843524;38201.61798381981;47260.29109563428;48433.75783121203;49042.26436603382;49899.75050124726;50091;10055.547500362647;10113.14038306752;10436.217283703905;10541.631042913461;10592;10788.298760580537;10794.352338859693;11087.501062452371;11182.440877956233;11194.216404851582;7348.889766653611;8613.827723445622;9834.901650983398;10218.489075546342;10567;10198.286119971828;10209.84685229737;10245.231607629607;10267.589296428358;10277;10030.448325342177;10037.598496060367;10391.37651740898;10512.57949682004;10902.672919812418;10818.29681070728;11075;11190.888091118984;11288.435578220891;11427.657170284905;10771.461426928465;10840.132789376674;10842.295250808673;10901.291416057931;10908.727281818017 17:25:50 INFO - PROCESS | 25110 | |3;mootools.html;1316.4207748590625;1504.3305728950616;1514.9242537873106;1661.1279078483794;1824.5165031266708;7301.342879140876;7633.961830190841;7653.158152603216;7653.158152603216;7655.425843061778;7347.155077166128;7511.211322811108;7511.474196806225;7530.548167109977;7537.510061845976;1976.5355141541727;2007.488090536911;2010.577778666482;2014.4762361785895;2016.959660806783;2206.117552978805;2216.7339919209717;2237.038073628339;2244.8540844845115;2257.3792207143083;2202.6365649667864;2216;2227.7326720793526;2229.9108035678555;2234.20685656592;2163.5023944492777;2177.3903307073965;2182.2798476502876;2182.9345119646355;2184.3337781976493;2094.05767404667;2150.7204063471804;2152.3435352217566;2156.0944403350472;2157.2988778647004;7515.173330933593;7546.2831031051965;7594;7598.126215485235;7713.537187768696;4455.487618923833;4582.266837306049;4593.012502311985;4594.081183763227;4610.308453731934;2792.176307989148;2803.0889960762834;2833.0509279391426;2855.3860919902113;2868.0965495868736;928.0533855467453;965.560669895196;966.2366730283068;973.732223638498;977.5845265762023;9939;10272.28094033418;10280.74298142545;10303.639372621998;10311.896881031169;4028.8992775180855;4043.939340909889;4172.916541669149;4175.770332631734;4176.874693759192;8088.352931765445;8127.715529956541;8131.18688131194;8136.34909207262;8143.063547691972;4584.679072464962;4622.583967442946;4628.976855115703;4637.791299391535;4638.628909687217;3624.4200927851416;3921.254961557295;3980.7412518186225;3989.341758609855;4150.06623509714;3369.646187150363;3445.4487282035257;3493.825308734553;3501.9299614008087;3601.297746939374;1017.1151098544314;1049.338916482611;1052.6894566103017;1054.641421916552;1054.9261551691309;865.8657908024267;884.4737381258141;898.7708134425679;899.4198741811495;918.150710592699;5116.488351164854;5150.665206761549;5198.506141916512;5251.842444726664;5275.20871869215;433.2872424861086;439.3563429575687;441.2300535565395;951.6574033347989;951.8381875081253;3428.194374322032;3475.878344257939;3506.631803660579;3544.663256990582;3567.8216089195957;8811.118888111137;9061.728148155566;9074.546272686339;9170.495622740813;9188.540572971324;9029.097090290918;9058.094190580889;9086.681966131153;9177.90822091784;9195.90804091964;7004.719811207495;7273.709051637981;7292.34368906801;7318.963405183046;7338.376238019828;4964.453910069961;4966.453690094159;5071.39143302806;5081.415637201621;5107.87230319245;8690.26132778721;8783.560821959005;8790.208881200468;8791.076936921787;8797.164269394398;8721.084286149862;8814.471131732116;8855.203031726918;8899.555022248991;8984.955075224581;5431.158170483582;5927.881442371215;6119.938800612115;6175.228096487939;6241.906371404523;6994.2656021117045;7030.121234845645;7067.964660176666;7085.50401471892;7097.787066388017;6125.816225513242;6190.319064902767;6280.654563999024;6281.685915704288;6285.465735412541;6184.072389141665;6238.563300569098;6251.53113516479;6320.494360451245;6348.111264422892;6041.18444010053;6064.514838812973;6107.053406721965;6117.021276595723;6117.541184411276;4293.549177336335;4356.76037817923;4430.3575981483145;4433.889152771207;4497.955020449754;4331.177076355482;4456.153330867125;4485.416895803524;4498.280275155959;4587.4036375271 17:25:50 INFO - PROCESS | 25110 | |4;prototype.html;296.4086647138957;306.8159104537277;308.52487169758575;309.1976321445847;310.5171458382215;4470.329450582414;4649.349091127245;4712.246040633499;4743.952560474394;4747.979184475337;4518.728876267426;4661.207594708899;4668.229742092551;4689.22627766419;4706.152892479352;3740.17716102457;3769.227308401778;3770.5852356240794;3773.169902621433;3784.678302344304;3531.3579185678655;3600.4959305697225;3726.9254614907686;3746.9437958430644;3747.0819649185987;3731.477593136963;3761.4357846323132;3770.2271034437877;3772.622737726233;3783.9432408513894;3725.795081270529;3741.120836603396;3742.644448777362;3754.7371683982133;3775.62243775623;3347.598288205431;3349.69852713257;3357.446021406465;3359.563256776628;3361.226917808893;4281.614654681093;4509.684322097454;4554.43069616298;4557.931631025537;4606.286025666027;4150.315197992328;4186.434831297796;4205;4206.275427074885;4208.158368326316;4897.363342765453;4930.975345123252;4935.2843837643695;4976.4525902150735;4978.950210497885;3339.248669049469;3518;3538.221591249921;3553.8045407502577;3555.1112221944513;5089.160288552422;5106.183010718267;5115.795368185268;5131.358580177478;5135.537801597874;3562.8218589070443;3576.302620988882;3604.8377822998027;3606.765560238576;3609.9458508122398;3624.7643903146213;3662.2675464907124;3672.9632703673155;3674.338619048597;3713.702903767692;3968.861089861841;4149.439825623563;4194.8112334945;4201.374141161774;4216.7259128156575;4916.410030796327;4929.408470983505;4950.752462376867;4956.8760780980765;4964.354633897642;1256.8303279057393;1274.4010315151863;1300.4213125159213;1302.2056545507232;1328.3756634381825;895.0780695883251;895.5208963204784;903.0788595632549;911.8541033434618;920.4845286639503;4579.084183163381;4591.770411479412;4594.563516465931;4598.770061496912;4606.055758569485;5368.798792495137;5371;5372.91940620891;5385.057614917374;5392.656552937204;4477.485089214782;4590;4594.609458196091;4600.263957766741;4610.40064791575;2858.1711303722104;2861.0701522005015;2872.4255148970287;2880.53092922611;2883.6107125537783;5059.392872855281;5074;5074.644774865724;5079.085764562415;5097.235414687826;5319.28189694394;5437.45625437461;5465.508104270635;5486.0125177468435;5506.752196151103;5023.6483446159145;5053.343065401475;5056.469070747518;5066.746662666926;5068.087744206005;5340.519353258225;5355.3305836770405;5361.115415956324;5363.410024897336;5374.623776335776;4815.277708343777;5073.92389114171;5087.745612719424;5245.344331958505;5255.2379904912805;4860.3681521401995;4862.902741945212;4892.412910450626;4903.8528844134735;4912.729799861042;3623.963760362363;3627.8186090695885;3683.31858606148;3686.972165309123;3696.7597106188014;4866.1727506323305;5017.394433781155;5081.4918508148885;5160.290847305195;5160.380754309507;4809.831655892027;4927.285543596086;4982.6512144149565;4999.425066117443;5000.899982000413;4958.851234462972;4970.279309500174;4975.5522003019905;4990.72551009698;4991.625628077836;4637.86086417408;4895.46149923501;4896.314515967839;4901.460839307744;4914.336564563881;5001.599872010158;5029.0947629427055;5038.39539255277;5038.672486288379;5054.924176137288;4904.950950490592;4927.310176575211;4928;4936.136176169084;4936.481669424658 17:25:50 INFO - PROCESS | 25110 | |5;yui.html;635.7933671556742;637.5432137565664;729.0995620408794;738.0884607509724;739.5710487917007;11586.362750048744;11952.76094478111;12266.632001039961;12308.323042232663;12372.443240054197;11944;11988.40057997101;11992.340421276826;12004.099692523074;12072.215306005104;878.4597472554365;884.995575022124;890.6481939633873;891.2780647675404;891.9965039330752;694.9722011119549;843.8143608406172;880.4673172730502;884.3941899798626;885.0883589902411;908.4458480327029;909.8225845960008;910.3036177324352;910.4764760262842;911.8814554107956;723.0744646852038;905.5834316214549;907.079314495784;907.1925985872579;907.2515174980634;652.5530011941787;671.781670956941;673.9359760822714;674.2179072276185;674.564905635867;12413.131080824345;12479.75040499194;12494.81257781134;12509.311987840665;12618.936905315415;12095.818562721566;12565.371731413485;12658.55695050678;12719.427625756864;12983.675408114777;9774.951125244399;9941.204703623765;10109.292349535535;10131.493425328777;10462.633807816766;3397.065806903097;3400.846961886721;3417.043227896193;3529.0471572675233;3544.4328907374697;43100.78449607732;43119.568804312185;43140.56859431397;43206.56793432057;43210;10155.289129760846;10210.948945255226;10255.7436064099;10304;10326.122279606318;17803.910980445275;17857.821421785615;17931.641367172582;18024.188911499015;18125.63748725018;6806.285340039323;6960.117579652761;6980.546264492792;7063.011178435023;7132.358087772125;3925.293447179535;3963.1083006323347;4019.9397009044887;4026.9597304026584;4130.710850240454;2912.97087029127;3010.5785190073407;3021.471242532548;3025.1680787783534;3025.183200535843;505.2345696270154;515.8375111839833;519.0941806547598;525.7003508000403;533.4185737546094;600.2586805295457;619.7366119399237;627.109504503606;638.3967151042314;643.9034144878306;7280.162781280114;7356.521826081287;7479.102507699111;7626.084869815658;7632.389408847279;558.7625259264796;590.2444870565682;594.818580332994;608.1728848765675;611.8348046027637;3467.878624248139;3479.5128681984543;3592.2276710507367;3616.6021737608844;3653.3606618842127;47969.28046079312;51053.23420148701;51058.723531912;51184;51272.23091653628;42165;43030;43994.78002609967;44659.33011004837;45329;41830.37254441186;42066.369004464956;42099.368509472384;42339;42382.78808605937;6619.3380661933425;7101.715931362688;7203.495755297079;7283.453740969342;7359.337659610661;27667.72332276732;28483.572746408405;28713.712862871103;28980.420391592474;29165.562516561844;35663.28673426569;36634.26731465409;36828.26343473062;36976.63023369732;37026.814865925495;8971.461712297283;9083.227925626396;9222.815543689223;9284.02517735655;9312;10164.542595583365;10479.42363170033;10514.737131571772;10835.241533092609;11793.410329483662;10373.948130259301;10657.573697052341;10688.465576720977;11169.441527923735;11440.48517816717;10569.524371403151;10980.176486763685;11098.2786118902;11312;11557.479913404086;10770.407627580558;10971;11436.199466037298;11452.541898324307;11729.824052639387;8850.513221772606;9230.707780795632;9254.953725231331;9287.99064907039;9344;8999.685011024583;9141.542922853963;9145.877189053645;9153.684923254505;9416.435013899189 17:25:50 INFO - PROCESS | 25110 | __end_tp_report 17:25:50 INFO - PROCESS | 25110 | __start_cc_report 17:25:50 INFO - PROCESS | 25110 | _x_x_mozilla_cycle_collect,910 17:25:50 INFO - PROCESS | 25110 | __end_cc_report 17:25:50 INFO - PROCESS | 25110 | __startTimestamp1462407950211__endTimestamp 17:25:50 INFO - PROCESS | 25110 | 17:25:50 INFO - PROCESS | 25110 | ------- Summary: start ------- 17:25:50 INFO - PROCESS | 25110 | Number of tests: 6 17:25:50 INFO - PROCESS | 25110 | 17:25:50 INFO - PROCESS | 25110 | [#0] dojo.html Cycles:165 Average:4611.08 Median:4742.64 stddev:477.69 (10.1%) stddev-sans-first:451.16 17:25:50 INFO - PROCESS | 25110 | Values: 2556.9 2602.9 2611.6 2628.4 2641.8 4521.3 4545.0 4568.5 4569.2 4626.2 4606.0 4631.2 4665.3 4725.8 4736.3 4246.1 4251.0 4279.7 4313.9 4460.8 4342.4 4370.9 4395.6 4397.4 4436.6 4221.3 4232.5 4242.2 4306.8 4314.4 4291.7 4308.4 4312.2 4316.6 4357.2 4291.5 4306.2 4309.8 4335.5 4342.0 4470.2 4534.7 4541.6 4630.7 4641.7 4964.0 4969.5 4972.1 4978.0 5008.8 5015.5 5015.8 5020.5 5023.6 5041.7 4597.2 4687.0 4738.8 4742.6 4743.8 5070.8 5114.3 5115.8 5117.3 5118.1 4769.7 4914.1 4918.7 4919.2 4959.0 4866.4 4889.2 4919.3 4951.2 4963.9 4906.4 4908.5 4914.6 4919.8 4967.9 4800.7 4878.4 4890.9 4894.7 4943.3 4216.7 4222.2 4223.4 4246.5 4264.8 3679.9 3724.1 3728.2 3751.0 3773.3 4193.5 4241.8 4263.4 4289.6 4324.4 5029.3 5049.5 5051.1 5054.3 5101.4 4307.6 4317.9 4318.5 4321.7 4368.7 4446.1 4453.2 4523.1 4528.6 4564.1 4710.9 4726.8 4738.7 4754.1 4782.0 5014.7 5020.1 5022.1 5034.9 5080.3 4587.4 4689.9 4731.0 4776.0 4790.4 4892.7 4907.6 4920.7 4932.3 4969.1 4911.7 4987.2 5005.6 5007.6 5052.2 4772.3 4831.1 4889.3 4913.1 4925.6 4825.9 4826.2 4845.5 4861.3 4902.1 4591.7 4739.5 4767.5 4770.3 4836.6 4898.7 4934.5 4939.0 4971.4 4991.9 4738.7 4791.8 4793.8 4818.0 4839.3 17:25:50 INFO - PROCESS | 25110 | 17:25:50 INFO - PROCESS | 25110 | [#1] ext.html Cycles:180 Average:47488.13 Median:38514.52 stddev:81683.72 (212.1%) stddev-sans-first:81836.99 17:25:50 INFO - PROCESS | 25110 | Values: 597.4 613.0 623.9 633.0 645.5 35495.3 37281.8 37320.6 37447.8 37478.1 43128.4 43708.3 43796.1 43860.0 43929.3 7812.5 8068.1 8068.2 8068.3 8072.6 7873.3 7988.1 8007.9 8011.9 8017.3 7970.8 8027.8 8051.6 8052.2 8057.9 7931.8 7940.2 7994.2 8015.5 8020.1 7839.1 7978.8 8044.4 8047.3 8050.6 39515.8 39803.0 40150.4 40207.8 40245.8 2931.2 3000.2 3113.3 3143.7 3741.8 30152.0 30202.7 30259.5 30512.8 30735.0 3135.9 3145.2 3172.6 3191.8 3246.3 247350.0 248586.0 248638.0 249925.0 250188.0 42989.8 57188.7 57651.4 57681.7 57734.7 51277.5 53267.7 53355.5 53385.0 53414.7 13120.5 13180.4 13338.0 13385.3 13564.0 8965.3 9964.4 10733.2 10840.3 10869.3 17611.0 17821.9 17822.8 17827.9 17894.3 5831.8 5854.9 5925.6 5959.9 6047.1 857.6 872.2 927.2 996.5 1003.2 25727.5 26211.9 26272.7 26308.5 26491.0 993.9 1027.7 1037.7 1041.8 1055.8 14392.4 14677.9 14983.7 15177.2 15286.9 339484.0 339535.0 343162.0 345482.0 345554.0 50528.5 50907.0 51336.7 51339.5 51505.5 1262.4 1287.7 1292.1 1298.9 1317.6 26820.7 27371.2 28649.9 28793.3 28934.0 49445.3 50226.2 50527.0 50554.5 50682.0 325005.0 334352.0 336680.0 336989.0 337025.0 33110.3 33725.0 37115.4 37545.0 37657.8 41693.4 43419.8 43522.3 45300.8 47120.1 38521.2 38969.6 39130.0 39175.0 39756.8 37820.6 38507.8 38549.0 38616.4 38993.4 38034.0 38791.0 38869.2 38996.8 39067.6 32282.4 34158.5 34892.3 34901.7 35282.6 25954.1 26403.9 26413.6 26708.0 26798.5 17:25:50 INFO - PROCESS | 25110 | 17:25:50 INFO - PROCESS | 25110 | [#2] jquery.html Cycles:180 Average:22481.93 Median:12009.51 stddev:53899.08 (448.8%) stddev-sans-first:54024.73 17:25:50 INFO - PROCESS | 25110 | Values: 377.3 385.3 389.0 393.6 402.8 16022.0 16631.4 17325.9 17357.3 17379.0 17548.1 17831.8 18109.4 18247.5 18449.7 5022.4 5158.1 5183.7 5199.7 5203.6 3673.1 4552.6 5914.3 5918.9 5933.8 5690.8 5862.7 5914.6 5919.2 5943.1 5806.7 5889.2 5902.8 5903.4 5912.3 5114.2 5144.4 5195.7 5238.7 5246.7 21081.0 21342.4 21638.0 21678.9 21771.6 1881.9 1995.0 2146.2 2247.4 2259.9 12884.4 12983.7 13032.9 13091.7 13631.2 1685.6 1798.1 1816.4 1821.4 1933.7 67747.0 68873.7 69640.0 69991.0 70821.7 9851.1 9917.6 10074.8 10121.9 10272.5 13877.3 13939.5 14012.6 14067.7 14073.2 7167.6 7356.8 7360.2 7428.1 7444.6 6821.9 6873.0 6960.9 6971.6 6988.8 6219.8 6291.2 6332.4 6332.6 6498.0 1825.3 1844.0 1846.3 1857.8 1875.6 826.4 875.0 930.8 989.9 1050.3 16589.2 17376.7 17418.2 17529.6 17699.5 912.4 915.8 949.8 965.8 970.6 9735.8 10172.9 10175.1 10192.8 10260.1 306214.0 311237.0 311702.0 314130.0 380241.0 48226.5 50517.0 69044.0 74788.0 76130.6 964.2 981.0 1003.8 1012.9 1020.3 11356.3 15757.4 16073.5 16233.7 16289.3 32513.7 35029.9 37229.0 37487.4 38201.6 47260.3 48433.8 49042.3 49899.8 50091.0 10055.5 10113.1 10436.2 10541.6 10592.0 10788.3 10794.4 11087.5 11182.4 11194.2 7348.9 8613.8 9834.9 10218.5 10567.0 10198.3 10209.8 10245.2 10267.6 10277.0 10030.4 10037.6 10391.4 10512.6 10902.7 10818.3 11075.0 11190.9 11288.4 11427.7 10771.5 10840.1 10842.3 10901.3 10908.7 17:25:50 INFO - PROCESS | 25110 | 17:25:50 INFO - PROCESS | 25110 | [#3] mootools.html Cycles:180 Average:4937.06 Median:5094.64 stddev:2726.04 (53.5%) stddev-sans-first:2720.11 17:25:50 INFO - PROCESS | 25110 | Values: 1316.4 1504.3 1514.9 1661.1 1824.5 7301.3 7634.0 7653.2 7653.2 7655.4 7347.2 7511.2 7511.5 7530.5 7537.5 1976.5 2007.5 2010.6 2014.5 2017.0 2206.1 2216.7 2237.0 2244.9 2257.4 2202.6 2216.0 2227.7 2229.9 2234.2 2163.5 2177.4 2182.3 2182.9 2184.3 2094.1 2150.7 2152.3 2156.1 2157.3 7515.2 7546.3 7594.0 7598.1 7713.5 4455.5 4582.3 4593.0 4594.1 4610.3 2792.2 2803.1 2833.1 2855.4 2868.1 928.1 965.6 966.2 973.7 977.6 9939.0 10272.3 10280.7 10303.6 10311.9 4028.9 4043.9 4172.9 4175.8 4176.9 8088.4 8127.7 8131.2 8136.3 8143.1 4584.7 4622.6 4629.0 4637.8 4638.6 3624.4 3921.3 3980.7 3989.3 4150.1 3369.6 3445.4 3493.8 3501.9 3601.3 1017.1 1049.3 1052.7 1054.6 1054.9 865.9 884.5 898.8 899.4 918.2 5116.5 5150.7 5198.5 5251.8 5275.2 433.3 439.4 441.2 951.7 951.8 3428.2 3475.9 3506.6 3544.7 3567.8 8811.1 9061.7 9074.5 9170.5 9188.5 9029.1 9058.1 9086.7 9177.9 9195.9 7004.7 7273.7 7292.3 7319.0 7338.4 4964.5 4966.5 5071.4 5081.4 5107.9 8690.3 8783.6 8790.2 8791.1 8797.2 8721.1 8814.5 8855.2 8899.6 8985.0 5431.2 5927.9 6119.9 6175.2 6241.9 6994.3 7030.1 7068.0 7085.5 7097.8 6125.8 6190.3 6280.7 6281.7 6285.5 6184.1 6238.6 6251.5 6320.5 6348.1 6041.2 6064.5 6107.1 6117.0 6117.5 4293.5 4356.8 4430.4 4433.9 4498.0 4331.2 4456.2 4485.4 4498.3 4587.4 17:25:50 INFO - PROCESS | 25110 | 17:25:50 INFO - PROCESS | 25110 | [#4] prototype.html Cycles:180 Average:4180.85 Median:4678.73 stddev:1213.04 (25.9%) stddev-sans-first:1180.89 17:25:50 INFO - PROCESS | 25110 | Values: 296.4 306.8 308.5 309.2 310.5 4470.3 4649.3 4712.2 4744.0 4748.0 4518.7 4661.2 4668.2 4689.2 4706.2 3740.2 3769.2 3770.6 3773.2 3784.7 3531.4 3600.5 3726.9 3746.9 3747.1 3731.5 3761.4 3770.2 3772.6 3783.9 3725.8 3741.1 3742.6 3754.7 3775.6 3347.6 3349.7 3357.4 3359.6 3361.2 4281.6 4509.7 4554.4 4557.9 4606.3 4150.3 4186.4 4205.0 4206.3 4208.2 4897.4 4931.0 4935.3 4976.5 4979.0 3339.2 3518.0 3538.2 3553.8 3555.1 5089.2 5106.2 5115.8 5131.4 5135.5 3562.8 3576.3 3604.8 3606.8 3609.9 3624.8 3662.3 3673.0 3674.3 3713.7 3968.9 4149.4 4194.8 4201.4 4216.7 4916.4 4929.4 4950.8 4956.9 4964.4 1256.8 1274.4 1300.4 1302.2 1328.4 895.1 895.5 903.1 911.9 920.5 4579.1 4591.8 4594.6 4598.8 4606.1 5368.8 5371.0 5372.9 5385.1 5392.7 4477.5 4590.0 4594.6 4600.3 4610.4 2858.2 2861.1 2872.4 2880.5 2883.6 5059.4 5074.0 5074.6 5079.1 5097.2 5319.3 5437.5 5465.5 5486.0 5506.8 5023.6 5053.3 5056.5 5066.7 5068.1 5340.5 5355.3 5361.1 5363.4 5374.6 4815.3 5073.9 5087.7 5245.3 5255.2 4860.4 4862.9 4892.4 4903.9 4912.7 3624.0 3627.8 3683.3 3687.0 3696.8 4866.2 5017.4 5081.5 5160.3 5160.4 4809.8 4927.3 4982.7 4999.4 5000.9 4958.9 4970.3 4975.6 4990.7 4991.6 4637.9 4895.5 4896.3 4901.5 4914.3 5001.6 5029.1 5038.4 5038.7 5054.9 4905.0 4927.3 4928.0 4936.1 4936.5 17:25:50 INFO - PROCESS | 25110 | 17:25:50 INFO - PROCESS | 25110 | [#5] yui.html Cycles:180 Average:12392.09 Median:43110.18 stddev:13810.74 (32.0%) stddev-sans-first:13821.27 17:25:50 INFO - PROCESS | 25110 | Values: 635.8 637.5 729.1 738.1 739.6 11586.4 11952.8 12266.6 12308.3 12372.4 11944.0 11988.4 11992.3 12004.1 12072.2 878.5 885.0 890.6 891.3 892.0 695.0 843.8 880.5 884.4 885.1 908.4 909.8 910.3 910.5 911.9 723.1 905.6 907.1 907.2 907.3 652.6 671.8 673.9 674.2 674.6 12413.1 12479.8 12494.8 12509.3 12618.9 12095.8 12565.4 12658.6 12719.4 12983.7 9775.0 9941.2 10109.3 10131.5 10462.6 3397.1 3400.8 3417.0 3529.0 3544.4 43100.8 43119.6 43140.6 43206.6 43210.0 10155.3 10210.9 10255.7 10304.0 10326.1 17803.9 17857.8 17931.6 18024.2 18125.6 6806.3 6960.1 6980.5 7063.0 7132.4 3925.3 3963.1 4019.9 4027.0 4130.7 2913.0 3010.6 3021.5 3025.2 3025.2 505.2 515.8 519.1 525.7 533.4 600.3 619.7 627.1 638.4 643.9 7280.2 7356.5 7479.1 7626.1 7632.4 558.8 590.2 594.8 608.2 611.8 3467.9 3479.5 3592.2 3616.6 3653.4 47969.3 51053.2 51058.7 51184.0 51272.2 42165.0 43030.0 43994.8 44659.3 45329.0 41830.4 42066.4 42099.4 42339.0 42382.8 6619.3 7101.7 7203.5 7283.5 7359.3 27667.7 28483.6 28713.7 28980.4 29165.6 35663.3 36634.3 36828.3 36976.6 37026.8 8971.5 9083.2 9222.8 9284.0 9312.0 10164.5 10479.4 10514.7 10835.2 11793.4 10373.9 10657.6 10688.5 11169.4 11440.5 10569.5 10980.2 11098.3 11312.0 11557.5 10770.4 10971.0 11436.2 11452.5 11729.8 8850.5 9230.7 9255.0 9288.0 9344.0 8999.7 9141.5 9145.9 9153.7 9416.4 17:25:50 INFO - PROCESS | 25110 | -------- Summary: end -------- 17:25:50 INFO - PROCESS | 25110 | 17:25:51 INFO - TEST-INFO | 25110: exit 0 17:25:51 INFO - TEST-OK | dromaeo_css | took 1117970ms 17:25:51 INFO - TEST-START | kraken 17:25:51 INFO - operating with platform_type : linux_ 17:25:51 INFO - Initialising browser for kraken test... 17:25:51 INFO - TEST-INFO | started process 25287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWAp439/profile http://localhost:52362/getInfo.html) 17:25:55 INFO - PROCESS | 25287 | __metrics Screen width/height:1600/1200 17:25:55 INFO - PROCESS | 25287 | colorDepth:24 17:25:55 INFO - PROCESS | 25287 | Browser inner width/height: 1024/697 17:25:55 INFO - PROCESS | 25287 | __metrics 17:25:56 ERROR - PROCESS | 25287 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:25:57 INFO - TEST-INFO | 25287: exit 0 17:25:57 INFO - Browser initialized. 17:25:57 INFO - Running cycle 1/1 for kraken test... 17:25:57 INFO - TEST-INFO | started process 25373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWAp439/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:09 INFO - PROCESS | 25373 | RSS: Main: 156762112 17:26:09 INFO - PROCESS | 25373 | 17:26:12 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52362/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:13 INFO - PROCESS | 25373 | RSS: Main: 211144704 17:26:13 INFO - PROCESS | 25373 | 17:26:15 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52362/tests/kraken/driver.html?testName=audio-dft) 17:26:16 INFO - PROCESS | 25373 | RSS: Main: 198389760 17:26:16 INFO - PROCESS | 25373 | 17:26:19 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52362/tests/kraken/driver.html?testName=audio-fft) 17:26:20 INFO - PROCESS | 25373 | RSS: Main: 268255232 17:26:20 INFO - PROCESS | 25373 | 17:26:22 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52362/tests/kraken/driver.html?testName=audio-oscillator) 17:26:23 INFO - PROCESS | 25373 | RSS: Main: 175759360 17:26:23 INFO - PROCESS | 25373 | 17:26:25 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:26 INFO - PROCESS | 25373 | RSS: Main: 179433472 17:26:26 INFO - PROCESS | 25373 | 17:26:29 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52362/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:29 INFO - PROCESS | 25373 | RSS: Main: 215732224 17:26:29 INFO - PROCESS | 25373 | 17:26:33 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52362/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:33 INFO - PROCESS | 25373 | RSS: Main: 217174016 17:26:33 INFO - PROCESS | 25373 | 17:26:36 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52362/tests/kraken/driver.html?testName=json-parse-financial) 17:26:37 INFO - PROCESS | 25373 | RSS: Main: 216641536 17:26:37 INFO - PROCESS | 25373 | 17:26:39 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:39 INFO - PROCESS | 25373 | RSS: Main: 205672448 17:26:39 INFO - PROCESS | 25373 | 17:26:41 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:42 INFO - PROCESS | 25373 | RSS: Main: 204554240 17:26:42 INFO - PROCESS | 25373 | 17:26:44 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:45 INFO - PROCESS | 25373 | RSS: Main: 216944640 17:26:45 INFO - PROCESS | 25373 | 17:26:47 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:48 INFO - PROCESS | 25373 | RSS: Main: 225619968 17:26:48 INFO - PROCESS | 25373 | 17:26:51 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:52 INFO - PROCESS | 25373 | RSS: Main: 220553216 17:26:52 INFO - PROCESS | 25373 | 17:26:53 INFO - PROCESS | 25373 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52362/tests/kraken/driver.html?testName=ai-astar) 17:26:54 INFO - PROCESS | 25373 | RSS: Main: 284581888 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | __start_tp_report 17:26:54 INFO - PROCESS | 25373 | _x_x_mozilla_page_load 17:26:54 INFO - PROCESS | 25373 | _x_x_mozilla_page_load_details 17:26:54 INFO - PROCESS | 25373 | |i|pagename|runs| 17:26:54 INFO - PROCESS | 25373 | |0;ai-astar;111;116;109;115;115;116;105;114;114;114 17:26:54 INFO - PROCESS | 25373 | |1;audio-beat-detection;164;139;156;190;134;156;153;133;188;140 17:26:54 INFO - PROCESS | 25373 | |2;audio-dft;163;162;162;162;161;163;162;161;162;160 17:26:54 INFO - PROCESS | 25373 | |3;audio-fft;74;75;125;130;78;77;74;126;114;74 17:26:54 INFO - PROCESS | 25373 | |4;audio-oscillator;95;95;149;95;94;94;148;94;94;151 17:26:54 INFO - PROCESS | 25373 | |5;imaging-gaussian-blur;116;116;116;118;117;117;117;117;118;117 17:26:54 INFO - PROCESS | 25373 | |6;imaging-darkroom;146;147;145;146;146;145;146;145;146;145 17:26:54 INFO - PROCESS | 25373 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;95;95 17:26:54 INFO - PROCESS | 25373 | |8;json-parse-financial;65;67;68;66;68;69;69;86;64;65 17:26:54 INFO - PROCESS | 25373 | |9;json-stringify-tinderbox;64;65;65;65;64;65;65;65;65;65 17:26:54 INFO - PROCESS | 25373 | |10;stanford-crypto-aes;79;81;78;80;82;84;89;81;80;86 17:26:54 INFO - PROCESS | 25373 | |11;stanford-crypto-ccm;131;134;143;132;130;132;131;131;180;140 17:26:54 INFO - PROCESS | 25373 | |12;stanford-crypto-pbkdf2;185;178;184;182;181;180;178;182;175;178 17:26:54 INFO - PROCESS | 25373 | |13;stanford-crypto-sha256-iterative;77;73;73;73;73;74;73;73;74;73 17:26:54 INFO - PROCESS | 25373 | __end_tp_report 17:26:54 INFO - PROCESS | 25373 | __start_cc_report 17:26:54 INFO - PROCESS | 25373 | _x_x_mozilla_cycle_collect,1883 17:26:54 INFO - PROCESS | 25373 | __end_cc_report 17:26:54 INFO - PROCESS | 25373 | __startTimestamp1462408014225__endTimestamp 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | ------- Summary: start ------- 17:26:54 INFO - PROCESS | 25373 | Number of tests: 14 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.50 stddev:3.54 (3.1%) stddev-sans-first:3.69 17:26:54 INFO - PROCESS | 25373 | Values: 111.0 116.0 109.0 115.0 115.0 116.0 105.0 114.0 114.0 114.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:156.00 stddev:20.56 (13.2%) stddev-sans-first:21.57 17:26:54 INFO - PROCESS | 25373 | Values: 164.0 139.0 156.0 190.0 134.0 156.0 153.0 133.0 188.0 140.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 17:26:54 INFO - PROCESS | 25373 | Values: 163.0 162.0 162.0 162.0 161.0 163.0 162.0 161.0 162.0 160.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#3] audio-fft Cycles:10 Average:94.70 Median:74.00 stddev:25.35 (34.3%) stddev-sans-first:25.75 17:26:54 INFO - PROCESS | 25373 | Values: 74.0 75.0 125.0 130.0 78.0 77.0 74.0 126.0 114.0 74.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:94.00 stddev:26.53 (28.2%) stddev-sans-first:27.51 17:26:54 INFO - PROCESS | 25373 | Values: 95.0 95.0 149.0 95.0 94.0 94.0 148.0 94.0 94.0 151.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 17:26:54 INFO - PROCESS | 25373 | Values: 116.0 116.0 116.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:26:54 INFO - PROCESS | 25373 | Values: 146.0 147.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:26:54 INFO - PROCESS | 25373 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:68.00 stddev:6.33 (9.3%) stddev-sans-first:6.57 17:26:54 INFO - PROCESS | 25373 | Values: 65.0 67.0 68.0 66.0 68.0 69.0 69.0 86.0 64.0 65.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 17:26:54 INFO - PROCESS | 25373 | Values: 64.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:3.40 (4.2%) stddev-sans-first:3.43 17:26:54 INFO - PROCESS | 25373 | Values: 79.0 81.0 78.0 80.0 82.0 84.0 89.0 81.0 80.0 86.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:133.00 stddev:15.24 (11.5%) stddev-sans-first:15.93 17:26:54 INFO - PROCESS | 25373 | Values: 131.0 134.0 143.0 132.0 130.0 132.0 131.0 131.0 180.0 140.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:181.50 stddev:3.09 (1.7%) stddev-sans-first:2.77 17:26:54 INFO - PROCESS | 25373 | Values: 185.0 178.0 184.0 182.0 181.0 180.0 178.0 182.0 175.0 178.0 17:26:54 INFO - PROCESS | 25373 | 17:26:54 INFO - PROCESS | 25373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:73.00 stddev:1.26 (1.7%) stddev-sans-first:0.44 17:26:54 INFO - PROCESS | 25373 | Values: 77.0 73.0 73.0 73.0 73.0 74.0 73.0 73.0 74.0 73.0 17:26:54 INFO - PROCESS | 25373 | -------- Summary: end -------- 17:26:54 INFO - PROCESS | 25373 | 17:26:55 INFO - TEST-INFO | 25373: exit 0 17:26:55 INFO - TEST-OK | kraken | took 64248ms 17:26:55 INFO - SUITE-END | took 1182s 17:26:55 INFO - Completed test suite (00:19:42) 17:26:55 INFO - javascript benchmark 17:26:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2556.8721563921804, 2602.8958841646336, 2611.569091099969, 2628.3691913940647, 2641.788656907447, 4521.276595744682, 4544.977275113624, 4568.474625418074, 4569.223232050551, 4626.190416677076, 4605.976970115154, 4631.212693842046, 4665.300204969256, 4725.810967561302, 4736.265878788785, 4246.065865509583, 4250.957490425087, 4279.679024073207, 4313.935290970638, 4460.754658493782, 4342.413774140482, 4370.912581748379, 4395.604395604395, 4397.428334316534, 4436.622887054588, 4221.324588065895, 4232.470941132358, 4242.172776308621, 4306.849260275907, 4314.374415709736, 4291.678124140671, 4308.439902812645, 4312.180685669713, 4316.568343165658, 4357.1721372939355, 4291.527931927517, 4306.246406878784, 4309.806058727365, 4335.544767799367, 4341.978290108561, 4470.150671372428, 4534.727916325031, 4541.591256786905, 4630.72215667061, 4641.721496710208, 4964.0, 4969.453360130383, 4972.105021096201, 4978.0, 5008.84973450797, 5015.473375295578, 5015.774290156952, 5020.523050310215, 5023.598112151019, 5041.697498150123, 4597.218472859622, 4686.95313046872, 4738.8341408050555, 4742.644301677388, 4743.762811859393, 5070.822521211814, 5114.28400023997, 5115.769790359368, 5117.283580298761, 5118.129917913963, 4769.73766442842, 4914.140025495595, 4918.655694101379, 4919.2129259318335, 4958.975205124024, 4866.440359358719, 4889.168841296988, 4919.311296418504, 4951.183054795991, 4963.925541116886, 4906.386701662293, 4908.460069392364, 4914.631402644816, 4919.803207871717, 4967.90064198714, 4800.687955282895, 4878.390201224847, 4890.853274401774, 4894.67843682211, 4943.332650092263, 4216.725912815718, 4222.155568886235, 4223.387608796707, 4246.4691913510815, 4264.808083636244, 3679.8528058877882, 3724.1062145084984, 3728.217074414349, 3751.0, 3773.3208022555655, 4193.496780386373, 4241.830326786956, 4263.424437700871, 4289.635380992589, 4324.394584758136, 5029.27075574047, 5049.545540901337, 5051.090803655304, 5054.317667114892, 5101.413337466165, 4307.612314891675, 4317.892052698708, 4318.5033721121845, 4321.67587430944, 4368.737875727466, 4446.110777844444, 4453.153900758845, 4523.140603285366, 4528.615067719281, 4564.0871825635, 4710.882227944192, 4726.834560790493, 4738.715677059387, 4754.144254034238, 4781.976090119666, 5014.724190169576, 5020.071286811952, 5022.096022715946, 5034.924476132787, 5080.314157588678, 4587.4036375271, 4689.882752931204, 4730.952690473051, 4775.952240477551, 4790.377250957354, 4892.657513973988, 4907.631927605516, 4920.72935988524, 4932.30947667334, 4969.130402179532, 4911.68074075184, 4987.202047672355, 5005.62457815658, 5007.649464537593, 5052.242163675331, 4772.308015337826, 4831.130396528659, 4889.266610008385, 4913.066517361833, 4925.605951523798, 4825.855224343275, 4826.203676393356, 4845.49122342149, 4861.270809378621, 4902.117618828645, 4591.678582499193, 4739.47865734762, 4767.523247675204, 4770.308305295644, 4836.588889944394, 4898.681585696918, 4934.506549345037, 4939.0, 4971.403431588088, 4991.8752031198055, 4738.739369334719, 4791.808327666854, 4793.832215872567, 4817.975910120427, 4839.2983017462975], "value": 4580.842532082478, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.3906615252442, 613.025289789235, 623.940725631065, 633.0188208277173, 645.4803882874285, 35495.2900941981, 37281.81359093204, 37320.62679373205, 37447.81276093623, 37478.063048423806, 43128.353074703824, 43708.3443748344, 43796.12407751843, 43860.0, 43929.34105988413, 7812.531248125117, 8068.112507624186, 8068.152843951389, 8068.314193293548, 8072.55600941948, 7873.330766884822, 7988.081370642363, 8007.919920800776, 8011.879821802678, 8017.278444939954, 7970.800729981739, 8027.799305017363, 8051.597420128999, 8052.235037671441, 8057.919420805775, 7931.801704957365, 7940.166282540308, 7994.160613135595, 8015.47899386538, 8020.11778704342, 7839.098503672037, 7978.760637180894, 8044.396670249755, 8047.275745182962, 8050.59747012647, 39515.80242098771, 39803.0, 40150.397744033864, 40207.7989610053, 40245.79877100625, 2931.193921671536, 3000.219942814884, 3113.2839446927333, 3143.748500120008, 3741.8316175772156, 30152.0, 30202.69797302043, 30259.546106808415, 30512.84743576268, 30735.0, 3135.937281254362, 3145.2294187923876, 3172.5558421820965, 3191.824449655268, 3246.2533617267923, 247349.9999999982, 248586.0, 248638.0, 249925.0, 250188.0, 42989.78505107454, 57188.71405642945, 57651.423485765445, 57681.71159144177, 57734.71132644394, 51277.48722512727, 53267.73366133145, 53355.46644533583, 53385.0, 53414.7329263359, 13120.540781072617, 13180.406881690347, 13337.999650026286, 13385.330733463288, 13564.0, 8965.327600429993, 9964.352317099365, 10733.248672593, 10840.29538080038, 10869.293495922899, 17611.0, 17821.910890445466, 17822.821771782375, 17827.910860445616, 17894.284228630968, 5831.825045248649, 5854.882902342015, 5925.555583331267, 5959.851003724942, 6047.123167140828, 857.648364170687, 872.2455076358904, 927.2165020557753, 996.496769131584, 1003.2174903575223, 25727.48545029089, 26211.868940655557, 26272.73727262703, 26308.473830523282, 26491.0, 993.9353941993747, 1027.6505987964129, 1037.699067270483, 1041.796849614318, 1055.8310670292717, 14392.35234414454, 14677.92661036688, 14983.700325993419, 15177.16525591081, 15286.923565382102, 339484.0, 339535.0, 343162.0, 345482.0, 345554.0, 50528.494715053115, 50907.0, 51336.74331628318, 51339.48660513422, 51505.48494515007, 1262.3940508555945, 1287.7424515096832, 1292.095533126815, 1298.8831005209577, 1317.571789168505, 26820.731792681825, 27371.178864634094, 28649.856750716113, 28793.280167995967, 28934.0, 49445.25832112449, 50226.24660630167, 50527.0, 50554.49445505498, 50682.0, 325005.0, 334352.0, 336680.0, 336989.0, 337025.0, 33110.337793244486, 33725.0, 37115.44326835046, 37545.0, 37657.81171094127, 41693.37459938164, 43419.782901085295, 43522.34716479319, 45300.77349613231, 47120.057598848514, 38521.22957540889, 38969.610303896596, 39130.0, 39175.0, 39756.801215993735, 37820.62179378171, 38507.80746096252, 38549.0, 38616.42075368816, 38993.41509877411, 38034.0, 38791.0, 38869.2226155481, 38996.805015974736, 39067.6093239064, 32282.35435291328, 34158.487622686174, 34892.30215395627, 34901.65098349086, 35282.647173527934, 25954.07680430328, 26403.867980659972, 26413.60379594346, 26708.0, 26798.5161928948], "value": 17958.038637129, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.2737480350325, 385.29298736817935, 388.96888248940087, 393.6240889950098, 402.7945747668692, 16021.999999999985, 16631.41790037349, 17325.91337043316, 17357.30570777169, 17379.0, 17548.12259387032, 17831.821681783178, 18109.366172183974, 18247.54381140472, 18449.7232541512, 5022.422421421537, 5158.123119069767, 5183.714895680736, 5199.714015729133, 5203.635745497817, 3673.1184515716304, 4552.567506086916, 5914.260717410324, 5918.911216331759, 5933.792317268896, 5690.829275121753, 5862.677552734598, 5914.585978981473, 5919.17131601574, 5943.078822782476, 5806.738696758634, 5889.1755154278435, 5902.822915312548, 5903.35063143054, 5912.320083190445, 5114.181730923072, 5144.382674079135, 5195.714235717034, 5238.73806309683, 5246.737663116829, 21081.0, 21342.359729207994, 21638.0, 21678.89160554203, 21771.564568708538, 1881.8588605854616, 1994.9700754488695, 2146.248812915467, 2247.449374903159, 2259.8757068361233, 12884.355782210852, 12983.675408114777, 13032.869671303355, 13091.738165236642, 13631.182129072287, 1685.6123091688858, 1798.0650061967833, 1816.3642725046127, 1821.3898344054626, 1933.6712758831034, 67747.0, 68873.65563172151, 69640.0, 69991.0, 70821.6883733722, 9851.113399794052, 9917.603295868084, 10074.798504030025, 10121.898781012243, 10272.537735801907, 13877.306134693225, 13939.512117076056, 14012.579622611338, 14067.71864562703, 14073.225972571607, 7167.605781682058, 7356.816079597946, 7360.2271761465345, 7428.145763237297, 7444.627768611548, 6821.897671534931, 6872.965635171792, 6960.895586566206, 6971.58170509771, 6988.755393561302, 6219.844503887349, 6291.245050593867, 6332.430081292706, 6332.575170586673, 6497.967510162419, 1825.3063835742332, 1843.9539011524819, 1846.270723064382, 1857.8142185781585, 1875.6436277107307, 826.4173757501068, 874.9737507874773, 930.8138372325427, 989.8614194012844, 1050.2700623067049, 16589.17054147288, 17376.65246695059, 17418.23822515746, 17529.561760955825, 17699.469015929542, 912.4479689787715, 915.7573243090586, 949.8005418861978, 965.8213230552229, 970.6457143142702, 9735.805283894282, 10172.898271017342, 10175.08424241807, 10192.796144077225, 10260.067654240147, 306214.0, 311237.0, 311702.0, 314130.0, 380241.0, 48226.517734822904, 50517.0, 69044.0, 74788.0, 76130.61934690402, 964.1804466203811, 980.9950950245203, 1003.7641154328727, 1012.8531362952479, 1020.3010937507831, 11356.318620882774, 15757.369705211662, 16073.517794466185, 16233.67532649364, 16289.266982986032, 32513.67486325201, 35029.949101526996, 37229.0, 37487.43768843524, 38201.61798381981, 47260.29109563428, 48433.75783121203, 49042.26436603382, 49899.75050124726, 50091.0, 10055.547500362647, 10113.14038306752, 10436.217283703905, 10541.631042913461, 10592.0, 10788.298760580537, 10794.352338859693, 11087.501062452371, 11182.440877956233, 11194.216404851582, 7348.889766653611, 8613.827723445622, 9834.901650983398, 10218.489075546342, 10567.0, 10198.286119971828, 10209.84685229737, 10245.231607629607, 10267.589296428358, 10277.0, 10030.448325342177, 10037.598496060367, 10391.37651740898, 10512.57949682004, 10902.672919812418, 10818.29681070728, 11075.0, 11190.888091118984, 11288.435578220891, 11427.657170284905, 10771.461426928465, 10840.132789376674, 10842.295250808673, 10901.291416057931, 10908.727281818017], "value": 8588.745417855682, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.4207748590625, 1504.3305728950616, 1514.9242537873106, 1661.1279078483794, 1824.5165031266708, 7301.342879140876, 7633.961830190841, 7653.158152603216, 7653.158152603216, 7655.425843061778, 7347.155077166128, 7511.211322811108, 7511.474196806225, 7530.548167109977, 7537.510061845976, 1976.5355141541727, 2007.488090536911, 2010.577778666482, 2014.4762361785895, 2016.959660806783, 2206.117552978805, 2216.7339919209717, 2237.038073628339, 2244.8540844845115, 2257.3792207143083, 2202.6365649667864, 2216.0, 2227.7326720793526, 2229.9108035678555, 2234.20685656592, 2163.5023944492777, 2177.3903307073965, 2182.2798476502876, 2182.9345119646355, 2184.3337781976493, 2094.05767404667, 2150.7204063471804, 2152.3435352217566, 2156.0944403350472, 2157.2988778647004, 7515.173330933593, 7546.2831031051965, 7594.0, 7598.126215485235, 7713.537187768696, 4455.487618923833, 4582.266837306049, 4593.012502311985, 4594.081183763227, 4610.308453731934, 2792.176307989148, 2803.0889960762834, 2833.0509279391426, 2855.3860919902113, 2868.0965495868736, 928.0533855467453, 965.560669895196, 966.2366730283068, 973.732223638498, 977.5845265762023, 9939.0, 10272.28094033418, 10280.74298142545, 10303.639372621998, 10311.896881031169, 4028.8992775180855, 4043.939340909889, 4172.916541669149, 4175.770332631734, 4176.874693759192, 8088.352931765445, 8127.715529956541, 8131.18688131194, 8136.34909207262, 8143.063547691972, 4584.679072464962, 4622.583967442946, 4628.976855115703, 4637.791299391535, 4638.628909687217, 3624.4200927851416, 3921.254961557295, 3980.7412518186225, 3989.341758609855, 4150.06623509714, 3369.646187150363, 3445.4487282035257, 3493.825308734553, 3501.9299614008087, 3601.297746939374, 1017.1151098544314, 1049.338916482611, 1052.6894566103017, 1054.641421916552, 1054.9261551691309, 865.8657908024267, 884.4737381258141, 898.7708134425679, 899.4198741811495, 918.150710592699, 5116.488351164854, 5150.665206761549, 5198.506141916512, 5251.842444726664, 5275.20871869215, 433.2872424861086, 439.3563429575687, 441.2300535565395, 951.6574033347989, 951.8381875081253, 3428.194374322032, 3475.878344257939, 3506.631803660579, 3544.663256990582, 3567.8216089195957, 8811.118888111137, 9061.728148155566, 9074.546272686339, 9170.495622740813, 9188.540572971324, 9029.097090290918, 9058.094190580889, 9086.681966131153, 9177.90822091784, 9195.90804091964, 7004.719811207495, 7273.709051637981, 7292.34368906801, 7318.963405183046, 7338.376238019828, 4964.453910069961, 4966.453690094159, 5071.39143302806, 5081.415637201621, 5107.87230319245, 8690.26132778721, 8783.560821959005, 8790.208881200468, 8791.076936921787, 8797.164269394398, 8721.084286149862, 8814.471131732116, 8855.203031726918, 8899.555022248991, 8984.955075224581, 5431.158170483582, 5927.881442371215, 6119.938800612115, 6175.228096487939, 6241.906371404523, 6994.2656021117045, 7030.121234845645, 7067.964660176666, 7085.50401471892, 7097.787066388017, 6125.816225513242, 6190.319064902767, 6280.654563999024, 6281.685915704288, 6285.465735412541, 6184.072389141665, 6238.563300569098, 6251.53113516479, 6320.494360451245, 6348.111264422892, 6041.18444010053, 6064.514838812973, 6107.053406721965, 6117.021276595723, 6117.541184411276, 4293.549177336335, 4356.76037817923, 4430.3575981483145, 4433.889152771207, 4497.955020449754, 4331.177076355482, 4456.153330867125, 4485.416895803524, 4498.280275155959, 4587.4036375271], "value": 3989.1665544149078, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.4086647138957, 306.8159104537277, 308.52487169758575, 309.1976321445847, 310.5171458382215, 4470.329450582414, 4649.349091127245, 4712.246040633499, 4743.952560474394, 4747.979184475337, 4518.728876267426, 4661.207594708899, 4668.229742092551, 4689.22627766419, 4706.152892479352, 3740.17716102457, 3769.227308401778, 3770.5852356240794, 3773.169902621433, 3784.678302344304, 3531.3579185678655, 3600.4959305697225, 3726.9254614907686, 3746.9437958430644, 3747.0819649185987, 3731.477593136963, 3761.4357846323132, 3770.2271034437877, 3772.622737726233, 3783.9432408513894, 3725.795081270529, 3741.120836603396, 3742.644448777362, 3754.7371683982133, 3775.62243775623, 3347.598288205431, 3349.69852713257, 3357.446021406465, 3359.563256776628, 3361.226917808893, 4281.614654681093, 4509.684322097454, 4554.43069616298, 4557.931631025537, 4606.286025666027, 4150.315197992328, 4186.434831297796, 4205.0, 4206.275427074885, 4208.158368326316, 4897.363342765453, 4930.975345123252, 4935.2843837643695, 4976.4525902150735, 4978.950210497885, 3339.248669049469, 3518.0, 3538.221591249921, 3553.8045407502577, 3555.1112221944513, 5089.160288552422, 5106.183010718267, 5115.795368185268, 5131.358580177478, 5135.537801597874, 3562.8218589070443, 3576.302620988882, 3604.8377822998027, 3606.765560238576, 3609.9458508122398, 3624.7643903146213, 3662.2675464907124, 3672.9632703673155, 3674.338619048597, 3713.702903767692, 3968.861089861841, 4149.439825623563, 4194.8112334945, 4201.374141161774, 4216.7259128156575, 4916.410030796327, 4929.408470983505, 4950.752462376867, 4956.8760780980765, 4964.354633897642, 1256.8303279057393, 1274.4010315151863, 1300.4213125159213, 1302.2056545507232, 1328.3756634381825, 895.0780695883251, 895.5208963204784, 903.0788595632549, 911.8541033434618, 920.4845286639503, 4579.084183163381, 4591.770411479412, 4594.563516465931, 4598.770061496912, 4606.055758569485, 5368.798792495137, 5371.0, 5372.91940620891, 5385.057614917374, 5392.656552937204, 4477.485089214782, 4590.0, 4594.609458196091, 4600.263957766741, 4610.40064791575, 2858.1711303722104, 2861.0701522005015, 2872.4255148970287, 2880.53092922611, 2883.6107125537783, 5059.392872855281, 5074.0, 5074.644774865724, 5079.085764562415, 5097.235414687826, 5319.28189694394, 5437.45625437461, 5465.508104270635, 5486.0125177468435, 5506.752196151103, 5023.6483446159145, 5053.343065401475, 5056.469070747518, 5066.746662666926, 5068.087744206005, 5340.519353258225, 5355.3305836770405, 5361.115415956324, 5363.410024897336, 5374.623776335776, 4815.277708343777, 5073.92389114171, 5087.745612719424, 5245.344331958505, 5255.2379904912805, 4860.3681521401995, 4862.902741945212, 4892.412910450626, 4903.8528844134735, 4912.729799861042, 3623.963760362363, 3627.8186090695885, 3683.31858606148, 3686.972165309123, 3696.7597106188014, 4866.1727506323305, 5017.394433781155, 5081.4918508148885, 5160.290847305195, 5160.380754309507, 4809.831655892027, 4927.285543596086, 4982.6512144149565, 4999.425066117443, 5000.899982000413, 4958.851234462972, 4970.279309500174, 4975.5522003019905, 4990.72551009698, 4991.625628077836, 4637.86086417408, 4895.46149923501, 4896.314515967839, 4901.460839307744, 4914.336564563881, 5001.599872010158, 5029.0947629427055, 5038.39539255277, 5038.672486288379, 5054.924176137288, 4904.950950490592, 4927.310176575211, 4928.0, 4936.136176169084, 4936.481669424658], "value": 3802.5729154298365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.7933671556742, 637.5432137565664, 729.0995620408794, 738.0884607509724, 739.5710487917007, 11586.362750048744, 11952.76094478111, 12266.632001039961, 12308.323042232663, 12372.443240054197, 11944.0, 11988.40057997101, 11992.340421276826, 12004.099692523074, 12072.215306005104, 878.4597472554365, 884.995575022124, 890.6481939633873, 891.2780647675404, 891.9965039330752, 694.9722011119549, 843.8143608406172, 880.4673172730502, 884.3941899798626, 885.0883589902411, 908.4458480327029, 909.8225845960008, 910.3036177324352, 910.4764760262842, 911.8814554107956, 723.0744646852038, 905.5834316214549, 907.079314495784, 907.1925985872579, 907.2515174980634, 652.5530011941787, 671.781670956941, 673.9359760822714, 674.2179072276185, 674.564905635867, 12413.131080824345, 12479.75040499194, 12494.81257781134, 12509.311987840665, 12618.936905315415, 12095.818562721566, 12565.371731413485, 12658.55695050678, 12719.427625756864, 12983.675408114777, 9774.951125244399, 9941.204703623765, 10109.292349535535, 10131.493425328777, 10462.633807816766, 3397.065806903097, 3400.846961886721, 3417.043227896193, 3529.0471572675233, 3544.4328907374697, 43100.78449607732, 43119.568804312185, 43140.56859431397, 43206.56793432057, 43210.0, 10155.289129760846, 10210.948945255226, 10255.7436064099, 10304.0, 10326.122279606318, 17803.910980445275, 17857.821421785615, 17931.641367172582, 18024.188911499015, 18125.63748725018, 6806.285340039323, 6960.117579652761, 6980.546264492792, 7063.011178435023, 7132.358087772125, 3925.293447179535, 3963.1083006323347, 4019.9397009044887, 4026.9597304026584, 4130.710850240454, 2912.97087029127, 3010.5785190073407, 3021.471242532548, 3025.1680787783534, 3025.183200535843, 505.2345696270154, 515.8375111839833, 519.0941806547598, 525.7003508000403, 533.4185737546094, 600.2586805295457, 619.7366119399237, 627.109504503606, 638.3967151042314, 643.9034144878306, 7280.162781280114, 7356.521826081287, 7479.102507699111, 7626.084869815658, 7632.389408847279, 558.7625259264796, 590.2444870565682, 594.818580332994, 608.1728848765675, 611.8348046027637, 3467.878624248139, 3479.5128681984543, 3592.2276710507367, 3616.6021737608844, 3653.3606618842127, 47969.28046079312, 51053.23420148701, 51058.723531912, 51184.0, 51272.23091653628, 42165.0, 43030.0, 43994.78002609967, 44659.33011004837, 45329.0, 41830.37254441186, 42066.369004464956, 42099.368509472384, 42339.0, 42382.78808605937, 6619.3380661933425, 7101.715931362688, 7203.495755297079, 7283.453740969342, 7359.337659610661, 27667.72332276732, 28483.572746408405, 28713.712862871103, 28980.420391592474, 29165.562516561844, 35663.28673426569, 36634.26731465409, 36828.26343473062, 36976.63023369732, 37026.814865925495, 8971.461712297283, 9083.227925626396, 9222.815543689223, 9284.02517735655, 9312.0, 10164.542595583365, 10479.42363170033, 10514.737131571772, 10835.241533092609, 11793.410329483662, 10373.948130259301, 10657.573697052341, 10688.465576720977, 11169.441527923735, 11440.48517816717, 10569.524371403151, 10980.176486763685, 11098.2786118902, 11312.0, 11557.479913404086, 10770.407627580558, 10971.0, 11436.199466037298, 11452.541898324307, 11729.824052639387, 8850.513221772606, 9230.707780795632, 9254.953725231331, 9287.99064907039, 9344.0, 8999.685011024583, 9141.542922853963, 9145.877189053645, 9153.684923254505, 9416.435013899189], "value": 5909.3442574505725, "unit": "score"}], "name": "dromaeo_css", "value": 6313.658191503738, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 109.0, 115.0, 115.0, 116.0, 105.0, 114.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 139.0, 156.0, 190.0, 134.0, 156.0, 153.0, 133.0, 188.0, 140.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 161.0, 163.0, 162.0, 161.0, 162.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 125.0, 130.0, 78.0, 77.0, 74.0, 126.0, 114.0, 74.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 149.0, 95.0, 94.0, 94.0, 148.0, 94.0, 94.0, 151.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 68.0, 66.0, 68.0, 69.0, 69.0, 86.0, 64.0, 65.0], "value": 68.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 78.0, 80.0, 82.0, 84.0, 89.0, 81.0, 80.0, 86.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 134.0, 143.0, 132.0, 130.0, 132.0, 131.0, 131.0, 180.0, 140.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 178.0, 184.0, 182.0, 181.0, 180.0, 178.0, 182.0, 175.0, 178.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 73.0, 73.0, 73.0, 74.0, 73.0, 73.0, 74.0, 73.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1601.2, "alertThreshold": 2.0}]} 17:26:55 INFO - Return code: 0 17:26:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:26:55 ERROR - # TBPL SUCCESS # 17:26:55 INFO - Running post-action listener: _resource_record_post_action 17:26:55 INFO - Running post-run listener: _resource_record_post_run 17:26:56 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519049216; Read time: 200; Write time: 525528 17:26:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 234668032; Read time: 200; Write time: 261088 17:26:56 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284381184; Read time: 0; Write time: 264440 17:26:56 INFO - Running post-run listener: _upload_blobber_files 17:26:56 INFO - Blob upload gear active. 17:26:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:26:56 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 17:26:56 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:26:56 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:26:57 INFO - (blobuploader) - INFO - Open directory for files ... 17:26:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:26:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:26:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:57 INFO - (blobuploader) - INFO - Done attempting. 17:26:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:26:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:58 INFO - (blobuploader) - INFO - Done attempting. 17:26:58 INFO - (blobuploader) - INFO - Iteration through files over. 17:26:58 INFO - Return code: 0 17:26:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:26:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:26:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1adfe8f31a3a6f189993916f4c0428c6fe45deb147c4ef21b7deae0085867ae9e1adb94d4e1c8eb515277c41d8609b64934174b9ac03861e8f749f0fa1e14671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8a14f3d1d448eb63e276572714d6e12e86993628025155bfc73208258240371f62c88bee5fbc4f7cf0ee2514da142905c178c7e3ea1220aacae940632fba4ed"} 17:26:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:26:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:26:58 INFO - Contents: 17:26:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1adfe8f31a3a6f189993916f4c0428c6fe45deb147c4ef21b7deae0085867ae9e1adb94d4e1c8eb515277c41d8609b64934174b9ac03861e8f749f0fa1e14671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8a14f3d1d448eb63e276572714d6e12e86993628025155bfc73208258240371f62c88bee5fbc4f7cf0ee2514da142905c178c7e3ea1220aacae940632fba4ed"} 17:26:58 INFO - Running post-run listener: copy_logs_to_upload_dir 17:26:58 INFO - Copying logs to upload dir... 17:26:58 INFO - mkdir: /builds/slave/test/build/upload/logs 17:26:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.981172 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-04 17:26:56.488128) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:56.491972) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1adfe8f31a3a6f189993916f4c0428c6fe45deb147c4ef21b7deae0085867ae9e1adb94d4e1c8eb515277c41d8609b64934174b9ac03861e8f749f0fa1e14671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8a14f3d1d448eb63e276572714d6e12e86993628025155bfc73208258240371f62c88bee5fbc4f7cf0ee2514da142905c178c7e3ea1220aacae940632fba4ed"} build_url:https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/ai86J36WQuy71g4Ip3NfLQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1adfe8f31a3a6f189993916f4c0428c6fe45deb147c4ef21b7deae0085867ae9e1adb94d4e1c8eb515277c41d8609b64934174b9ac03861e8f749f0fa1e14671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8a14f3d1d448eb63e276572714d6e12e86993628025155bfc73208258240371f62c88bee5fbc4f7cf0ee2514da142905c178c7e3ea1220aacae940632fba4ed"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:56.516383) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:56.516702) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462402864.978397-366976101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:26:56.602243) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 17:26:56.602562) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 17:26:56.602849) ========= ========= Total master_lag: 0.15 =========