builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1462407155.24 results: success (0) buildid: 20160504164136 builduid: 47db4587604c48f1a4b5cf9e08241e1f revision: 9b7c96340a231119103f27106059b0524d22cea0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:35.242124) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:35.242608) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:35.242901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:35.273831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:35.274184) ========= 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=d2a8c569965ab8367867b893000001a1-1462406181.156839-817949772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-04 17:12:35-- 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% 217M=0s 2016-05-04 17:12:35 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136019 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:35.423452) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:35.423760) ========= 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=d2a8c569965ab8367867b893000001a1-1462406181.156839-817949772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020521 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:35.473435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:35.473772) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9b7c96340a231119103f27106059b0524d22cea0 --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 9b7c96340a231119103f27106059b0524d22cea0 --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=d2a8c569965ab8367867b893000001a1-1462406181.156839-817949772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-04 17:12:35,844 truncating revision to first 12 chars 2016-05-04 17:12:35,844 Setting DEBUG logging. 2016-05-04 17:12:35,844 attempt 1/10 2016-05-04 17:12:35,844 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9b7c96340a23?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-04 17:12:36,109 unpacking tar archive at: fx-team-9b7c96340a23/testing/mozharness/ program finished with exit code 0 elapsedTime=0.570786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:36.058018) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:36.058339) ========= script_repo_revision: 9b7c96340a231119103f27106059b0524d22cea0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:36.058757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:36.059028) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 17:12:36.066992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-04 17:12:36.067298) ========= /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=d2a8c569965ab8367867b893000001a1-1462406181.156839-817949772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:12:36 INFO - MultiFileLogger online at 20160504 17:12:36 in /builds/slave/test 17:12:36 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:12:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:12:36 INFO - {'append_to_log': False, 17:12:36 INFO - 'base_work_dir': '/builds/slave/test', 17:12:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:12:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:12:36 INFO - 'branch': 'Fx-Team-Non-PGO', 17:12:36 INFO - 'buildbot_json_path': 'buildprops.json', 17:12:36 INFO - 'config_files': ('talos/linux_config.py',), 17:12:36 INFO - 'default_actions': ('clobber', 17:12:36 INFO - 'read-buildbot-config', 17:12:36 INFO - 'download-and-extract', 17:12:36 INFO - 'populate-webroot', 17:12:36 INFO - 'create-virtualenv', 17:12:36 INFO - 'install', 17:12:36 INFO - 'run-tests'), 17:12:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:12:36 INFO - 'download_minidump_stackwalk': True, 17:12:36 INFO - 'download_symbols': 'ondemand', 17:12:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:12:36 INFO - 'tooltool.py': '/tools/tooltool.py', 17:12:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:12:36 INFO - '/tools/misc-python/virtualenv.py')}, 17:12:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:12:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:12:36 INFO - 'installer_path': 'installer.exe', 17:12:36 INFO - 'log_level': 'info', 17:12:36 INFO - 'log_name': 'talos', 17:12:36 INFO - 'log_to_console': True, 17:12:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:12:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:12:36 INFO - 'opt_config_files': (), 17:12:36 INFO - 'pip_index': False, 17:12:36 INFO - 'sps_profile': False, 17:12:36 INFO - 'sps_profile_interval': 0, 17:12:36 INFO - 'suite': 'dromaeojs', 17:12:36 INFO - 'system_bits': '32', 17:12:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:12:36 INFO - 'title': 'talos-linux64-ix-043', 17:12:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:12:36 INFO - 'use_talos_json': True, 17:12:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:12:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:12:36 INFO - 'work_dir': 'build'} 17:12:36 INFO - ##### 17:12:36 INFO - ##### Running clobber step. 17:12:36 INFO - ##### 17:12:36 INFO - Running pre-action listener: _resource_record_pre_action 17:12:36 INFO - Running main action method: clobber 17:12:36 INFO - rmtree: /builds/slave/test/build 17:12:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:12:36 INFO - Running post-action listener: _resource_record_post_action 17:12:36 INFO - ##### 17:12:36 INFO - ##### Running read-buildbot-config step. 17:12:36 INFO - ##### 17:12:36 INFO - Running pre-action listener: _resource_record_pre_action 17:12:36 INFO - Running main action method: read_buildbot_config 17:12:36 INFO - Using buildbot properties: 17:12:36 INFO - { 17:12:36 INFO - "project": "", 17:12:36 INFO - "product": "firefox", 17:12:36 INFO - "script_repo_revision": "production", 17:12:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:12:36 INFO - "repository": "", 17:12:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:12:36 INFO - "buildid": "20160504164136", 17:12:36 INFO - "pgo_build": "False", 17:12:36 INFO - "basedir": "/builds/slave/test", 17:12:36 INFO - "buildnumber": 1647, 17:12:36 INFO - "slavename": "talos-linux64-ix-043", 17:12:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:12:36 INFO - "platform": "ubuntu64_hw", 17:12:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:12:36 INFO - "branch": "fx-team", 17:12:36 INFO - "repo_path": "integration/fx-team", 17:12:36 INFO - "revision": "9b7c96340a231119103f27106059b0524d22cea0", 17:12:36 INFO - "stage_platform": "linux64", 17:12:36 INFO - "builduid": "47db4587604c48f1a4b5cf9e08241e1f", 17:12:36 INFO - "slavebuilddir": "test" 17:12:36 INFO - } 17:12:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:12:36 INFO - Running post-action listener: _resource_record_post_action 17:12:36 INFO - ##### 17:12:36 INFO - ##### Running download-and-extract step. 17:12:36 INFO - ##### 17:12:36 INFO - Running pre-action listener: _resource_record_pre_action 17:12:36 INFO - Running main action method: download_and_extract 17:12:36 INFO - mkdir: /builds/slave/test/build/tests 17:12:36 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:12:36 INFO - https://queue.taskcluster.net/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:12:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:12:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:12:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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:12:38 INFO - Downloaded 1361 bytes. 17:12:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:12:38 INFO - Using the following test package requirements: 17:12:38 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:38 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:12:38 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:12:38 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:38 INFO - u'jsshell-linux-x86_64.zip'], 17:12:38 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:12:38 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:38 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:12:38 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:12:38 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:12:38 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:12:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:38 INFO - https://queue.taskcluster.net/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:12:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:12:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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:12:39 INFO - Downloaded 22307347 bytes. 17:12:39 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:12:39 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:12:40 INFO - Return code: 0 17:12:40 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:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:40 INFO - https://queue.taskcluster.net/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:12:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:12:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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:12:57 INFO - Downloaded 22307347 bytes. 17:12:57 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:12:57 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:12:59 INFO - Return code: 0 17:12:59 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:12:59 INFO - https://queue.taskcluster.net/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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:13:00 INFO - Downloaded 10840152 bytes. 17:13:00 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:13:00 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:13:01 INFO - Return code: 0 17:13:01 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:13:01 INFO - https://queue.taskcluster.net/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:13:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:13:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:13:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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:13:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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:13:03 INFO - Downloaded 54870043 bytes. 17:13:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:13:03 INFO - mkdir: /builds/slave/test/properties 17:13:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:13:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:13:03 INFO - Contents: 17:13:03 INFO - build_url:https://queue.taskcluster.net/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:13:03 INFO - Running post-action listener: _resource_record_post_action 17:13:03 INFO - Running post-action listener: set_extra_try_arguments 17:13:03 INFO - ##### 17:13:03 INFO - ##### Running populate-webroot step. 17:13:03 INFO - ##### 17:13:03 INFO - Running pre-action listener: _resource_record_pre_action 17:13:03 INFO - Running main action method: populate_webroot 17:13:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:13:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:13:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:13:03 INFO - '--tppagecycles', 17:13:03 INFO - '7'], 17:13:03 INFO - 'tests': ['tsvgm']}}, 17:13:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:13:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:13:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:13:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:13:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:13:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:13:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:03 INFO - 'talos_options': ['--disable-e10s'], 17:13:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:03 INFO - 'talos_options': ['--disable-e10s'], 17:13:03 INFO - 'tests': ['damp', 'tps']}, 17:13:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:03 INFO - 'tests': ['damp', 'tps']}, 17:13:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:13:03 INFO - 'tests': ['dromaeo_dom']}, 17:13:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:13:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:13:03 INFO - 'tests': ['a11yr', 17:13:03 INFO - 'ts_paint', 17:13:03 INFO - 'tpaint', 17:13:03 INFO - 'sessionrestore', 17:13:03 INFO - 'sessionrestore_no_auto_restore', 17:13:03 INFO - 'tabpaint']}, 17:13:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:13:03 INFO - 'ts_paint', 17:13:03 INFO - 'tpaint', 17:13:03 INFO - 'sessionrestore', 17:13:03 INFO - 'sessionrestore_no_auto_restore', 17:13:03 INFO - 'tabpaint']}, 17:13:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:13:03 INFO - 'ts_paint', 17:13:03 INFO - 'tpaint', 17:13:03 INFO - 'sessionrestore', 17:13:03 INFO - 'sessionrestore_no_auto_restore', 17:13:03 INFO - 'tabpaint']}, 17:13:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:13:03 INFO - 'ts_paint', 17:13:03 INFO - 'tpaint', 17:13:03 INFO - 'sessionrestore', 17:13:03 INFO - 'sessionrestore_no_auto_restore', 17:13:03 INFO - 'tabpaint']}, 17:13:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:13:03 INFO - 'tests': ['a11yr', 17:13:03 INFO - 'ts_paint', 17:13:03 INFO - 'tpaint', 17:13:03 INFO - 'sessionrestore', 17:13:03 INFO - 'sessionrestore_no_auto_restore', 17:13:03 INFO - 'tabpaint']}, 17:13:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:13:03 INFO - 'tests': ['a11yr', 17:13:03 INFO - 'ts_paint', 17:13:03 INFO - 'tpaint', 17:13:03 INFO - 'sessionrestore', 17:13:03 INFO - 'sessionrestore_no_auto_restore', 17:13:03 INFO - 'tabpaint']}, 17:13:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:13:03 INFO - 'tests': ['tsvgx', 17:13:03 INFO - 'tsvgr_opacity', 17:13:03 INFO - 'tart', 17:13:03 INFO - 'tscrollx', 17:13:03 INFO - 'cart']}, 17:13:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:13:03 INFO - 'tsvgr_opacity', 17:13:03 INFO - 'tart', 17:13:03 INFO - 'tscrollx', 17:13:03 INFO - 'cart']}, 17:13:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:03 INFO - 'talos_options': ['--disable-e10s'], 17:13:03 INFO - 'tests': ['tp5o']}, 17:13:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:03 INFO - 'tests': ['tp5o']}, 17:13:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:03 INFO - 'talos_options': ['--disable-e10s', 17:13:03 INFO - '--xperf_path', 17:13:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:03 INFO - 'tests': ['tp5n']}, 17:13:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:03 INFO - 'talos_options': ['--xperf_path', 17:13:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:03 INFO - 'tests': ['tp5n']}}, 17:13:03 INFO - 'talos.zip': {'path': '', 17:13:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:13:03 INFO - Running post-action listener: _resource_record_post_action 17:13:03 INFO - ##### 17:13:03 INFO - ##### Running create-virtualenv step. 17:13:03 INFO - ##### 17:13:03 INFO - Running pre-action listener: _resource_record_pre_action 17:13:03 INFO - Running main action method: create_virtualenv 17:13:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:13:03 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:13:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:13:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:13:04 INFO - Using real prefix '/usr' 17:13:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:13:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:13:06 INFO - Installing pip.................done. 17:13:06 INFO - Return code: 0 17:13:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:13:06 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:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:06 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:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:06 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 0x7f9711feff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692410>, '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 0x1693310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16937a0>, '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': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', '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:13:06 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:13:06 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:13:06 INFO - Using env: {'DISPLAY': ':0', 17:13:06 INFO - 'HOME': '/home/cltbld', 17:13:06 INFO - 'LANG': 'en_US.UTF-8', 17:13:06 INFO - 'LANGUAGE': 'en_US:en', 17:13:06 INFO - 'LOGNAME': 'cltbld', 17:13:06 INFO - 'MAIL': '/var/mail/cltbld', 17:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:06 INFO - 'MOZ_NO_REMOTE': '1', 17:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:06 INFO - 'NO_EM_RESTART': '1', 17:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:06 INFO - 'PWD': '/builds/slave/test', 17:13:06 INFO - 'SHELL': '/bin/bash', 17:13:06 INFO - 'SHLVL': '1', 17:13:06 INFO - 'TERM': 'linux', 17:13:06 INFO - 'TMOUT': '86400', 17:13:06 INFO - 'USER': 'cltbld', 17:13:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', 17:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:06 INFO - '_': '/tools/buildbot/bin/python'} 17:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:06 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:13:06 INFO - Cleaning up... 17:13:06 INFO - Return code: 0 17:13:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:13:06 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:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:06 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:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:06 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 0x7f9711feff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692410>, '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 0x1693310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16937a0>, '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': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', '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:13:06 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:13:06 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:13:06 INFO - Using env: {'DISPLAY': ':0', 17:13:06 INFO - 'HOME': '/home/cltbld', 17:13:06 INFO - 'LANG': 'en_US.UTF-8', 17:13:06 INFO - 'LANGUAGE': 'en_US:en', 17:13:06 INFO - 'LOGNAME': 'cltbld', 17:13:06 INFO - 'MAIL': '/var/mail/cltbld', 17:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:06 INFO - 'MOZ_NO_REMOTE': '1', 17:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:06 INFO - 'NO_EM_RESTART': '1', 17:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:06 INFO - 'PWD': '/builds/slave/test', 17:13:06 INFO - 'SHELL': '/bin/bash', 17:13:06 INFO - 'SHLVL': '1', 17:13:06 INFO - 'TERM': 'linux', 17:13:06 INFO - 'TMOUT': '86400', 17:13:06 INFO - 'USER': 'cltbld', 17:13:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', 17:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:06 INFO - '_': '/tools/buildbot/bin/python'} 17:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:06 INFO - Downloading/unpacking psutil>=0.7.1 17:13:06 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:13:06 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:13:06 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:13:06 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:13:06 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:13:06 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:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:13:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:08 INFO - Installing collected packages: psutil 17:13:08 INFO - Running setup.py install for psutil 17:13:08 INFO - building 'psutil._psutil_linux' extension 17:13:08 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:13:09 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:13:09 INFO - building 'psutil._psutil_posix' extension 17:13:09 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:13:09 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:13:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:09 INFO - Successfully installed psutil 17:13:09 INFO - Cleaning up... 17:13:09 INFO - Return code: 0 17:13:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:13: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:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:09 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 0x7f9711feff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692410>, '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 0x1693310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16937a0>, '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': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', '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:13:09 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:13:09 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:13:09 INFO - Using env: {'DISPLAY': ':0', 17:13:09 INFO - 'HOME': '/home/cltbld', 17:13:09 INFO - 'LANG': 'en_US.UTF-8', 17:13:09 INFO - 'LANGUAGE': 'en_US:en', 17:13:09 INFO - 'LOGNAME': 'cltbld', 17:13:09 INFO - 'MAIL': '/var/mail/cltbld', 17:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:09 INFO - 'MOZ_NO_REMOTE': '1', 17:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:09 INFO - 'NO_EM_RESTART': '1', 17:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:09 INFO - 'PWD': '/builds/slave/test', 17:13:09 INFO - 'SHELL': '/bin/bash', 17:13:09 INFO - 'SHLVL': '1', 17:13:09 INFO - 'TERM': 'linux', 17:13:09 INFO - 'TMOUT': '86400', 17:13:09 INFO - 'USER': 'cltbld', 17:13:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', 17:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:09 INFO - '_': '/tools/buildbot/bin/python'} 17:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:11 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:13:11 INFO - Installing collected packages: mozsystemmonitor 17:13:11 INFO - Running setup.py install for mozsystemmonitor 17:13:11 INFO - Successfully installed mozsystemmonitor 17:13:11 INFO - Cleaning up... 17:13:11 INFO - Return code: 0 17:13:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:13: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:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:11 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 0x7f9711feff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692410>, '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 0x1693310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16937a0>, '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': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', '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:13:11 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:13:11 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:13:11 INFO - Using env: {'DISPLAY': ':0', 17:13:11 INFO - 'HOME': '/home/cltbld', 17:13:11 INFO - 'LANG': 'en_US.UTF-8', 17:13:11 INFO - 'LANGUAGE': 'en_US:en', 17:13:11 INFO - 'LOGNAME': 'cltbld', 17:13:11 INFO - 'MAIL': '/var/mail/cltbld', 17:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:11 INFO - 'MOZ_NO_REMOTE': '1', 17:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:11 INFO - 'NO_EM_RESTART': '1', 17:13:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:11 INFO - 'PWD': '/builds/slave/test', 17:13:11 INFO - 'SHELL': '/bin/bash', 17:13:11 INFO - 'SHLVL': '1', 17:13:11 INFO - 'TERM': 'linux', 17:13:11 INFO - 'TMOUT': '86400', 17:13:11 INFO - 'USER': 'cltbld', 17:13:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', 17:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:11 INFO - '_': '/tools/buildbot/bin/python'} 17:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:11 INFO - Downloading/unpacking blobuploader==1.2.4 17:13:11 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:13:11 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:13:11 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:13:11 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:13:11 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:13:11 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:13:13 INFO - Downloading blobuploader-1.2.4.tar.gz 17:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:13:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:13:13 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:13:13 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:13:13 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:13:13 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:13:13 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:13:13 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:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:13:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:14 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:13:14 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:13:14 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:13:14 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:13:14 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:13:14 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:13:14 INFO - Downloading docopt-0.6.1.tar.gz 17:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:14 INFO - Running setup.py install for blobuploader 17:13:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:13:14 INFO - Running setup.py install for requests 17:13:15 INFO - Running setup.py install for docopt 17:13:15 INFO - Successfully installed blobuploader requests docopt 17:13:15 INFO - Cleaning up... 17:13:15 INFO - Return code: 0 17:13:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:15 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 0x7f9711feff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692410>, '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 0x1693310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16937a0>, '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': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', '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:13:15 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:13:15 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:13:15 INFO - Using env: {'DISPLAY': ':0', 17:13:15 INFO - 'HOME': '/home/cltbld', 17:13:15 INFO - 'LANG': 'en_US.UTF-8', 17:13:15 INFO - 'LANGUAGE': 'en_US:en', 17:13:15 INFO - 'LOGNAME': 'cltbld', 17:13:15 INFO - 'MAIL': '/var/mail/cltbld', 17:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:15 INFO - 'MOZ_NO_REMOTE': '1', 17:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:15 INFO - 'NO_EM_RESTART': '1', 17:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:15 INFO - 'PWD': '/builds/slave/test', 17:13:15 INFO - 'SHELL': '/bin/bash', 17:13:15 INFO - 'SHLVL': '1', 17:13:15 INFO - 'TERM': 'linux', 17:13:15 INFO - 'TMOUT': '86400', 17:13:15 INFO - 'USER': 'cltbld', 17:13:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', 17:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:15 INFO - '_': '/tools/buildbot/bin/python'} 17:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:15 INFO - Running setup.py (path:/tmp/pip-CwzJLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:15 INFO - Running setup.py (path:/tmp/pip-egI2CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:15 INFO - Running setup.py (path:/tmp/pip-RWqgwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:15 INFO - Running setup.py (path:/tmp/pip-tcdIDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:15 INFO - Running setup.py (path:/tmp/pip-GYSzXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:15 INFO - Running setup.py (path:/tmp/pip-B7Oyit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:15 INFO - Running setup.py (path:/tmp/pip-8s74Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:15 INFO - Running setup.py (path:/tmp/pip-FHtwVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:16 INFO - Running setup.py (path:/tmp/pip-skX1hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:16 INFO - Running setup.py (path:/tmp/pip-eg4ajB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:16 INFO - Running setup.py (path:/tmp/pip-VwacvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:16 INFO - Running setup.py (path:/tmp/pip-kXXHYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:16 INFO - Running setup.py (path:/tmp/pip-jC7Lae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:16 INFO - Running setup.py (path:/tmp/pip-WXVAgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:16 INFO - Running setup.py (path:/tmp/pip-isTIsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:16 INFO - Running setup.py (path:/tmp/pip-S899UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:16 INFO - Running setup.py (path:/tmp/pip-MUp9SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:16 INFO - Running setup.py install for manifestparser 17:13:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:13:16 INFO - Running setup.py install for mozcrash 17:13:16 INFO - Running setup.py install for mozdebug 17:13:16 INFO - Running setup.py install for mozdevice 17:13:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Running setup.py install for mozfile 17:13:17 INFO - Running setup.py install for mozhttpd 17:13:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Running setup.py install for mozinfo 17:13:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Running setup.py install for mozInstall 17:13:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Running setup.py install for mozleak 17:13:17 INFO - Running setup.py install for mozlog 17:13:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Running setup.py install for moznetwork 17:13:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Running setup.py install for mozprocess 17:13:17 INFO - Running setup.py install for mozprofile 17:13:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:18 INFO - Running setup.py install for mozrunner 17:13:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:18 INFO - Running setup.py install for mozscreenshot 17:13:18 INFO - Running setup.py install for moztest 17:13:18 INFO - Running setup.py install for mozversion 17:13:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:18 INFO - Cleaning up... 17:13:18 INFO - Return code: 0 17:13:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:18 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 0x7f9711feff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692410>, '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 0x1693310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16937a0>, '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': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', '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:13:18 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:13:18 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:13:18 INFO - Using env: {'DISPLAY': ':0', 17:13:18 INFO - 'HOME': '/home/cltbld', 17:13:18 INFO - 'LANG': 'en_US.UTF-8', 17:13:18 INFO - 'LANGUAGE': 'en_US:en', 17:13:18 INFO - 'LOGNAME': 'cltbld', 17:13:18 INFO - 'MAIL': '/var/mail/cltbld', 17:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:18 INFO - 'MOZ_NO_REMOTE': '1', 17:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:18 INFO - 'NO_EM_RESTART': '1', 17:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:18 INFO - 'PWD': '/builds/slave/test', 17:13:18 INFO - 'SHELL': '/bin/bash', 17:13:18 INFO - 'SHLVL': '1', 17:13:18 INFO - 'TERM': 'linux', 17:13:18 INFO - 'TMOUT': '86400', 17:13:18 INFO - 'USER': 'cltbld', 17:13:18 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', 17:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:18 INFO - '_': '/tools/buildbot/bin/python'} 17:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:18 INFO - Running setup.py (path:/tmp/pip-9tDH8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:18 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:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:18 INFO - Running setup.py (path:/tmp/pip-unlxup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:18 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:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:18 INFO - Running setup.py (path:/tmp/pip-noxVMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:18 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:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:18 INFO - Running setup.py (path:/tmp/pip-I6p4w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:18 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:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:18 INFO - Running setup.py (path:/tmp/pip-zHJokf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:19 INFO - Running setup.py (path:/tmp/pip-7STVYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:19 INFO - Running setup.py (path:/tmp/pip-yPf4Zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:19 INFO - Running setup.py (path:/tmp/pip-cba6jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:19 INFO - Running setup.py (path:/tmp/pip-bxY9WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:19 INFO - Running setup.py (path:/tmp/pip-uU4H5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:19 INFO - Running setup.py (path:/tmp/pip-Z8STGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:19 INFO - Running setup.py (path:/tmp/pip-QpEhhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:19 INFO - Running setup.py (path:/tmp/pip-kGveS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:19 INFO - Running setup.py (path:/tmp/pip-ZzojbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:19 INFO - Running setup.py (path:/tmp/pip-g83s_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:19 INFO - Running setup.py (path:/tmp/pip-7GYQxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:19 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:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:19 INFO - Running setup.py (path:/tmp/pip-Gs6G0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:19 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:13:19 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:13:19 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:13:19 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:13:19 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:13:19 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:13:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:19 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:13:19 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:13:19 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:13:19 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:13:19 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:13:19 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:13:21 INFO - Downloading blessings-1.6.tar.gz 17:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:21 INFO - Installing collected packages: blessings 17:13:21 INFO - Running setup.py install for blessings 17:13:21 INFO - Successfully installed blessings 17:13:21 INFO - Cleaning up... 17:13:22 INFO - Return code: 0 17:13:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:22 INFO - Reading from file tmpfile_stdout 17:13:22 INFO - Current package versions: 17:13:22 INFO - argparse == 1.2.1 17:13:22 INFO - blessings == 1.6 17:13:22 INFO - blobuploader == 1.2.4 17:13:22 INFO - docopt == 0.6.1 17:13:22 INFO - manifestparser == 1.1 17:13:22 INFO - mozInstall == 1.12 17:13:22 INFO - mozcrash == 0.17 17:13:22 INFO - mozdebug == 0.1 17:13:22 INFO - mozdevice == 0.48 17:13:22 INFO - mozfile == 1.2 17:13:22 INFO - mozhttpd == 0.7 17:13:22 INFO - mozinfo == 0.9 17:13:22 INFO - mozleak == 0.1 17:13:22 INFO - mozlog == 3.1 17:13:22 INFO - moznetwork == 0.27 17:13:22 INFO - mozprocess == 0.22 17:13:22 INFO - mozprofile == 0.28 17:13:22 INFO - mozrunner == 6.11 17:13:22 INFO - mozscreenshot == 0.1 17:13:22 INFO - mozsystemmonitor == 0.0 17:13:22 INFO - moztest == 0.7 17:13:22 INFO - mozversion == 1.4 17:13:22 INFO - psutil == 3.1.1 17:13:22 INFO - requests == 1.2.3 17:13:22 INFO - wsgiref == 0.1.2 17:13:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:22 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:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:22 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:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:22 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 0x7f9711feff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692410>, '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 0x1693310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16937a0>, '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': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', '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:13:22 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:13:22 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:13:22 INFO - Using env: {'DISPLAY': ':0', 17:13:22 INFO - 'HOME': '/home/cltbld', 17:13:22 INFO - 'LANG': 'en_US.UTF-8', 17:13:22 INFO - 'LANGUAGE': 'en_US:en', 17:13:22 INFO - 'LOGNAME': 'cltbld', 17:13:22 INFO - 'MAIL': '/var/mail/cltbld', 17:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:22 INFO - 'MOZ_NO_REMOTE': '1', 17:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:22 INFO - 'NO_EM_RESTART': '1', 17:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:22 INFO - 'PWD': '/builds/slave/test', 17:13:22 INFO - 'SHELL': '/bin/bash', 17:13:22 INFO - 'SHLVL': '1', 17:13:22 INFO - 'TERM': 'linux', 17:13:22 INFO - 'TMOUT': '86400', 17:13:22 INFO - 'USER': 'cltbld', 17:13:22 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', 17:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:22 INFO - '_': '/tools/buildbot/bin/python'} 17:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:22 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:13:22 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:13:22 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:13:22 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:13:22 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:13:22 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:13:22 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:13:22 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:13:22 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:13:22 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:13:22 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:13:22 INFO - Cleaning up... 17:13:22 INFO - Return code: 0 17:13:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:13:22 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:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:22 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:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:22 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 0x7f9711feff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692410>, '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 0x1693310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16937a0>, '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': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', '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:13:22 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:13:22 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:13:22 INFO - Using env: {'DISPLAY': ':0', 17:13:22 INFO - 'HOME': '/home/cltbld', 17:13:22 INFO - 'LANG': 'en_US.UTF-8', 17:13:22 INFO - 'LANGUAGE': 'en_US:en', 17:13:22 INFO - 'LOGNAME': 'cltbld', 17:13:22 INFO - 'MAIL': '/var/mail/cltbld', 17:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:22 INFO - 'MOZ_NO_REMOTE': '1', 17:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:22 INFO - 'NO_EM_RESTART': '1', 17:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:22 INFO - 'PWD': '/builds/slave/test', 17:13:22 INFO - 'SHELL': '/bin/bash', 17:13:22 INFO - 'SHLVL': '1', 17:13:22 INFO - 'TERM': 'linux', 17:13:22 INFO - 'TMOUT': '86400', 17:13:22 INFO - 'USER': 'cltbld', 17:13:22 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', 17:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:22 INFO - '_': '/tools/buildbot/bin/python'} 17:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:22 INFO - Downloading/unpacking jsonschema 17:13:22 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:13:22 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:13:22 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:13:22 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:13:22 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:13:22 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:13:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:24 INFO - Downloading/unpacking functools32 (from jsonschema) 17:13:24 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:13:24 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:13:24 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:13:24 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:13:24 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:13:24 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:13:24 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:24 INFO - warning: no files found matching '*.txt' 17:13:24 INFO - no previously-included directories found matching 'build' 17:13:24 INFO - no previously-included directories found matching 'dist' 17:13:24 INFO - no previously-included directories found matching '.git*' 17:13:24 INFO - Installing collected packages: jsonschema, functools32 17:13:24 INFO - Running setup.py install for functools32 17:13:24 INFO - warning: no files found matching '*.txt' 17:13:24 INFO - no previously-included directories found matching 'build' 17:13:24 INFO - no previously-included directories found matching 'dist' 17:13:24 INFO - no previously-included directories found matching '.git*' 17:13:24 INFO - Successfully installed jsonschema functools32 17:13:24 INFO - Cleaning up... 17:13:25 INFO - Return code: 0 17:13:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:13: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:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:25 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 0x7f9711feff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16035a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692410>, '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 0x1693310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16937a0>, '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': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', '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:13:25 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:13:25 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:13:25 INFO - Using env: {'DISPLAY': ':0', 17:13:25 INFO - 'HOME': '/home/cltbld', 17:13:25 INFO - 'LANG': 'en_US.UTF-8', 17:13:25 INFO - 'LANGUAGE': 'en_US:en', 17:13:25 INFO - 'LOGNAME': 'cltbld', 17:13:25 INFO - 'MAIL': '/var/mail/cltbld', 17:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:25 INFO - 'MOZ_NO_REMOTE': '1', 17:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:25 INFO - 'NO_EM_RESTART': '1', 17:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:25 INFO - 'PWD': '/builds/slave/test', 17:13:25 INFO - 'SHELL': '/bin/bash', 17:13:25 INFO - 'SHLVL': '1', 17:13:25 INFO - 'TERM': 'linux', 17:13:25 INFO - 'TMOUT': '86400', 17:13:25 INFO - 'USER': 'cltbld', 17:13:25 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', 17:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:25 INFO - '_': '/tools/buildbot/bin/python'} 17:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:25 INFO - Downloading/unpacking flake8 17:13:25 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:13:25 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:13:25 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:13:25 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:13:25 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:13:25 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:13:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:13:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:13:27 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:13:27 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:13:27 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:13:27 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:13:27 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:13:27 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:13:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:13:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:13:27 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:13:27 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:13:27 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:13:27 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:13:27 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:13:27 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:13:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:13:27 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:13:27 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:13:27 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:13:27 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:13:27 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:13:27 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:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:27 INFO - no previously-included directories found matching 'docs/_build' 17:13:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:13:27 INFO - Running setup.py install for pep8 17:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:27 INFO - no previously-included directories found matching 'docs/_build' 17:13:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:13:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:13:28 INFO - Cleaning up... 17:13:28 INFO - Return code: 0 17:13:28 INFO - Running post-action listener: _resource_record_post_action 17:13:28 INFO - Running post-action listener: _start_resource_monitoring 17:13:28 INFO - Starting resource monitoring. 17:13:28 INFO - ##### 17:13:28 INFO - ##### Running install step. 17:13:28 INFO - ##### 17:13:28 INFO - Running pre-action listener: _resource_record_pre_action 17:13:28 INFO - Running main action method: install 17:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:28 INFO - Reading from file tmpfile_stdout 17:13:28 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:13:28 INFO - Reading from file tmpfile_stdout 17:13:28 INFO - Output received: 17:13:28 INFO - Usage: mozinstall [options] installer 17:13:28 INFO - Options: 17:13:28 INFO - -h, --help show this help message and exit 17:13:28 INFO - -d DEST, --destination=DEST 17:13:28 INFO - Directory to install application into. [default: 17:13:28 INFO - "/builds/slave/test"] 17:13:28 INFO - --app=APP Application being installed. [default: firefox] 17:13:28 INFO - mkdir: /builds/slave/test/build/application 17:13:28 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:13:28 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:13:44 INFO - Reading from file tmpfile_stdout 17:13:44 INFO - Output received: 17:13:44 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:44 INFO - Running post-action listener: _resource_record_post_action 17:13:44 INFO - ##### 17:13:44 INFO - ##### Running run-tests step. 17:13:44 INFO - ##### 17:13:44 INFO - Running pre-action listener: _resource_record_pre_action 17:13:44 INFO - Running main action method: run_tests 17:13:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:44 INFO - Python 2.7.3 17:13:44 INFO - Return code: 0 17:13:44 INFO - grabbing minidump binary from tooltool 17:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:44 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 0x1692410>, '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 0x1693310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16937a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:44 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:13:44 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:13:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:44 INFO - Return code: 0 17:13:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:13:45 INFO - Return code: 0 17:13:45 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/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:13:45 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/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:13:45 INFO - Using env: {'DISPLAY': ':0', 17:13:45 INFO - 'HOME': '/home/cltbld', 17:13:45 INFO - 'LANG': 'en_US.UTF-8', 17:13:45 INFO - 'LANGUAGE': 'en_US:en', 17:13:45 INFO - 'LOGNAME': 'cltbld', 17:13:45 INFO - 'MAIL': '/var/mail/cltbld', 17:13:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:45 INFO - 'MOZ_NO_REMOTE': '1', 17:13:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:45 INFO - 'NO_EM_RESTART': '1', 17:13:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:45 INFO - 'PWD': '/builds/slave/test', 17:13:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:45 INFO - 'SHELL': '/bin/bash', 17:13:45 INFO - 'SHLVL': '1', 17:13:45 INFO - 'TERM': 'linux', 17:13:45 INFO - 'TMOUT': '86400', 17:13:45 INFO - 'USER': 'cltbld', 17:13:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462406181.156839-817949772', 17:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:45 INFO - '_': '/tools/buildbot/bin/python'} 17:13:45 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/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:13:45 INFO - mozversion application_buildid: 20160504164136 17:13:45 INFO - mozversion application_changeset: 9b7c96340a231119103f27106059b0524d22cea0 17:13:45 INFO - mozversion application_display_name: Nightly 17:13:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:45 INFO - mozversion application_name: Firefox 17:13:45 INFO - mozversion application_remotingname: firefox 17:13:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:13:45 INFO - mozversion application_vendor: Mozilla 17:13:45 INFO - mozversion application_version: 49.0a1 17:13:45 INFO - mozversion platform_buildid: 20160504164136 17:13:45 INFO - mozversion platform_changeset: 9b7c96340a231119103f27106059b0524d22cea0 17:13:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:13:45 INFO - mozversion platform_version: 49.0a1 17:13:45 INFO - using testdate: 1462407225 17:13:45 INFO - actual date: 1462407225 17:13:45 INFO - starting webserver on 'localhost:53307' 17:13:45 INFO - SUITE-START | Running 2 tests 17:13:45 INFO - TEST-START | dromaeo_css 17:13:45 INFO - operating with platform_type : linux_ 17:13:45 INFO - Initialising browser for dromaeo_css test... 17:13:45 INFO - TEST-INFO | started process 17679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZe5dMe/profile http://localhost:53307/getInfo.html) 17:13:49 INFO - PROCESS | 17679 | __metrics Screen width/height:1600/1200 17:13:49 INFO - PROCESS | 17679 | colorDepth:24 17:13:49 INFO - PROCESS | 17679 | Browser inner width/height: 1024/697 17:13:49 INFO - PROCESS | 17679 | __metrics 17:13:51 ERROR - PROCESS | 17679 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:13:52 INFO - TEST-INFO | 17679: exit 0 17:13:52 INFO - Browser initialized. 17:13:52 INFO - Running cycle 1/1 for dromaeo_css test... 17:13:52 INFO - TEST-INFO | started process 17762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZe5dMe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:04 INFO - PROCESS | 17762 | RSS: Main: 156012544 17:14:04 INFO - PROCESS | 17762 | 17:14:54 INFO - PROCESS | 17762 | 1462407294856 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:17:06 INFO - PROCESS | 17762 | Cycle 1(1): loaded http://localhost:53307/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53307/tests/dromaeo/cssquery-ext.html) 17:17:08 INFO - PROCESS | 17762 | RSS: Main: 267505664 17:17:08 INFO - PROCESS | 17762 | 17:20:10 INFO - PROCESS | 17762 | Cycle 1(1): loaded http://localhost:53307/tests/dromaeo/cssquery-ext.html (next: http://localhost:53307/tests/dromaeo/cssquery-jquery.html) 17:20:11 INFO - PROCESS | 17762 | RSS: Main: 229650432 17:20:11 INFO - PROCESS | 17762 | 17:23:13 INFO - PROCESS | 17762 | Cycle 1(1): loaded http://localhost:53307/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53307/tests/dromaeo/cssquery-mootools.html) 17:23:14 INFO - PROCESS | 17762 | RSS: Main: 236232704 17:23:14 INFO - PROCESS | 17762 | 17:26:16 INFO - PROCESS | 17762 | Cycle 1(1): loaded http://localhost:53307/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53307/tests/dromaeo/cssquery-prototype.html) 17:26:16 INFO - PROCESS | 17762 | RSS: Main: 231559168 17:26:16 INFO - PROCESS | 17762 | 17:29:19 INFO - PROCESS | 17762 | Cycle 1(1): loaded http://localhost:53307/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53307/tests/dromaeo/cssquery-yui.html) 17:29:20 INFO - PROCESS | 17762 | RSS: Main: 211623936 17:29:20 INFO - PROCESS | 17762 | 17:32:23 INFO - PROCESS | 17762 | Cycle 1(1): loaded http://localhost:53307/tests/dromaeo/cssquery-yui.html (next: http://localhost:53307/tests/dromaeo/cssquery-dojo.html) 17:32:23 INFO - PROCESS | 17762 | RSS: Main: 269406208 17:32:23 INFO - PROCESS | 17762 | 17:32:23 INFO - PROCESS | 17762 | __start_tp_report 17:32:23 INFO - PROCESS | 17762 | _x_x_mozilla_page_load 17:32:23 INFO - PROCESS | 17762 | _x_x_mozilla_page_load_details 17:32:23 INFO - PROCESS | 17762 | |i|pagename|runs| 17:32:23 INFO - PROCESS | 17762 | |0;dojo.html;2566.255785822111;2584.728603496634;2618.3192369983813;2625.488029834182;2626.8555229462377;4552.726836389819;4577;4585.977070114649;4647.721136731799;4670.836520721776;4572.108438854417;4626.699264547802;4630.837920672777;4650.720956742598;4687.671862969593;4211.7051806373565;4224.788760561975;4253.1706317268145;4285.9571404286025;4394.846180383687;4332.523422423531;4362.716423432466;4389.626881715058;4410.140022695576;4410.71330363527;4225.239456897757;4294.957050429518;4302.354646802974;4305.870823875289;4323.286657701476;4253.553376895412;4265.7440553566885;4278.572142785696;4281.571842815724;4281.657467402601;4241.27898257297;4241.597048280409;4247.702660813744;4255.319148936186;4255.5744425557505;4486.170058539181;4505.887352816206;4522.7286362818;4557.79489922951;4598.977005114986;4985.803407182287;4998.600111991068;5015.498450154992;5065.392152941634;5067.138586440277;4853.150698627761;5016.648834581544;5025.974870125626;5040.294358789773;5045.344105266328;4521.502634710212;4559.452865656142;4560.087982403533;4597.632189424838;4609.700369475973;4954.380702412199;4979;4986.0277245936695;4993.251012348177;5011.148104822116;4775.42694876617;4784.138855006063;4786;4800.567948884617;4855.344528488679;4921.311016457699;4953.133201689762;4982.878852258285;4998;5003.524665156804;4883.169861123618;4892.156764802819;4895.290182923527;4896.290037944478;4941.925871111936;4821.662483626113;4877.073356062337;4890.437599676012;4890.902181956341;4941.135301322254;4104.138130992525;4154.958450415517;4187.895302617398;4207.326827707613;4230.15396920611;3635.2366003139637;3636.6908812751212;3641;3677.6138505457075;3681.815909204529;4174.3947127666315;4189.664826813848;4197.580241975778;4233.428487154195;4247.0444150066605;4950;4980.726060066731;4992.026554821775;5027.698338099725;5034.496550345009;4223.598758117974;4252.744835309892;4253.48958125027;4256.6807489438415;4296.634786043159;4386.1447017831215;4483.574060464251;4486.484054333793;4503.031848152597;4523.434570678665;4619.5611416915335;4655.324977878188;4658.161530924466;4664.090502352009;4664.39362882823;4892.486288939753;4896.534829191221;4900.14247506692;4902.7058376497525;4944.431390390151;4518.096380723802;4628.5371462853445;4630.07398520304;4634.073185362873;4677.204875171161;4866.48901865299;4885.975570122127;4900.387451568554;4927;4943.30793688891;4948.331975183304;4955.231939049453;4957.851264462072;4965.379327584052;5011.398632164163;4736.50266722003;4770.332153498443;4821.686590371614;4827.61379089679;4874.025194960951;4847.757612119451;4850.660453768202;4878.341423907869;4879.146149423907;4927.162382394929;4809.134355815987;4813.9037219256115;4829.637777166797;4831.710097394168;4851.32081508582;4752.239641657318;4858.5384388483035;4938.037082768826;4945.826896058621;4973.875653108701;4671.743054131919;4691.859244222543;4697.13103075932;4727.858164255078;4745.976270118627 17:32:23 INFO - PROCESS | 17762 | |1;ext.html;603.3031848215312;611.3214332091375;617.6109051297682;627.9560430769845;629.2260519560941;27022.594661080075;34717;34768.304633907304;35813.46279805805;36025;38046.239075218546;38820.41769373455;38855.80572097136;38937.22125557487;38963.41554876679;7294.270572942716;7567.394608431326;7884.211578842127;7925.247101525375;7930.088039875402;9639.71080867575;9867.210623150131;9920.355176913477;9927;9929.702108936743;9805.36265142767;9977.151942084894;9981.151602113829;9989;9996.150327222194;9968.3520571163;10117.494125293706;10139.138173255282;10141;10141.290109692325;9970.601175952954;10047.648332308334;10089.545970431349;10342.276040677156;10368.63709770162;37852.24295514074;38320;38329;38372.23255534874;38435;3285.8685652573868;3380.6957373836226;3406.5060566217758;3550.609432962372;3895.2793733159456;29940;30019.399612007855;30036.399272014438;30319.242018949702;31377.215569610715;2999.4151140527606;3014.3971205758717;3041.680623534541;3091.8144911305394;3140.434721750084;254181;255182;255216.99999999814;255302;255827;55676;56160.43839561634;56193.71903140458;56237.718811405684;56241;59303.40696593065;59387;59530.404695952486;59602.403975959685;59685;13437.193768373929;13748.450061997408;13879.236641984788;13895.305234738222;13922.443102275998;10186.541605627765;10196.694099177037;10216.846747298796;10222.744431389276;10225.74435639115;16010.759838602431;16577.585560361087;16721.581960450843;16780.160991950353;16788.160591970354;6601;6683.598984060972;6687.431568316651;6696.59820410777;6799.524033317719;946.342292106979;974.8635191073255;997.7328792433568;1005.3415013166388;1043.4678314059884;28840.567391489145;28936.948827164215;29069.7093029067;29472.263193420335;29629.703702962695;944.9433034017981;1019.8062368150028;1068.3643232276784;1069.2408390043156;1078.8489611454402;15520.92239538795;15530.689386212212;15609.644041388596;15627.296771645304;15721.449749258949;345519;352182;352658;353231;353787;50499.24251136236;51482.22776658353;51570.67931943072;51578;51591.74204128955;1177.6349331707197;1234.8394708687813;1284.2679672586537;1288.1176394170025;1318.1497933832816;28348.291292717848;30155.246118847204;30180.69819301779;31154.22114447157;31179.68820311768;45247.773761130986;47169.29246061243;47256;47301.29048064213;47310.290345644156;320069;332479;332489;332770;333695;30204.24489387783;35643.28713425769;36087.45868811917;36685.81657091698;37032.25935481329;41007;41544.58455415528;41661.37507937444;42206.577934220266;43985.34021989737;37736.245275094894;38243.42634860424;38324.6167538321;38699.2260154801;39146.651200928034;31992.520112198803;33091;37450;37811;38005;36892.077698057765;37008.25983480369;37381.25237495181;37511;37981.430278546395;32567.022989310357;33779;34120.317593648484;34386;34414.31171376609;25630.743692562835;25739.742602574483;26037.6094358581;26322.60516092222;26477.735222648298 17:32:23 INFO - PROCESS | 17762 | |2;jquery.html;375.5755995724834;376.4672987722372;378.36812523086445;385.4642047553901;388.1828750480239;16062.518124456255;16632.168391580417;17436.738448923275;17462.65074698505;17469.91265043673;16186.271617777198;16768.245428955695;16869.662606747857;16938.83061169388;16949.152542372893;3492.7775278652393;4691.50739172388;4919.901601967958;4923.335349727795;4926.901461970759;3664.926701465969;5295.602829787762;5561.63849349793;5563.276774019372;5570.637908535952;5249.370075590915;5526.668399895999;5538.723063846812;5540.778368865261;5542.612017158801;3483.7387195960405;5477.123660214366;5515.145152501369;5518.19986102015;5522.779088836442;5132.255822905695;5392.649477783932;5394.973025134888;5398.055340315429;5400;12071.215371000857;12283.263004219776;15585.454509092127;18947.43157705271;19498.512537186543;1881.4731875075001;1885.604023155139;1947.8102026735166;2108.95782084359;2196.6198951001875;9042.502662353569;9278.675246366345;9674.613015479372;11868.52525898963;13175.34123293841;1736.5484973906748;1775.3608700867806;1805.7110862261975;1808.3761102419644;1858.256697321069;65785;67426.3257367425;67754.66122669405;67868.6606566969;69152.6542367285;9840.704778856645;10134.493275336205;10411.427371494641;10465.26743127989;10599.629012984662;14307.85692143086;14418.711625767426;14423;14423.062500937405;14432.257871004476;7025.332593403618;7219.494635375473;7398.482106252511;7429.14564825052;7544.886826697604;7038.401735852408;7047.365737083687;7144.3212894774915;7169.641517924083;7198.496105272686;4383.890402739957;4460.888477788081;4465.173942820588;4547.8635640930825;4586.403767510203;1726.7927848658242;1757.1916918217507;1820.209857166817;1833.5480597519806;1935.854810889189;884.1512148337539;917.6100157433065;945.6028468043438;972.6547075788135;978.9965285582193;16234.107124108052;16814.915925420293;17185.570360741083;17461.214245358737;17722;934.9719508414759;949.9667511637059;958.6884262614678;966.4781018250206;1009.6415772400838;9475.384100033476;9508.714738557854;9731.610735570639;9790.510474476248;9872.259580531489;302044;305238;307684;309092;400767;77265.61367193128;79453.61184505731;81297.59351203206;81556;82132;965.7006328038331;988.8862780780158;1011.2870426349406;1012.9088382045651;1020.05644778581;15490.690186196438;15789;15794.9210253948;16041.518754437386;16411.42560010394;24974.750252497244;30103.698963010967;35516.644833551334;36162.09594760152;36987.07532311714;42501.837233601575;43608.78195609002;44110.33834492549;44491.11017779691;44550;7268.527545709512;7500.249975002456;7515.286047825448;7537.208593097866;7574.848503030019;9886;10911.290766100177;11006.834897476385;11077.169212308949;11292.266002709797;8913.242374398249;9295.209907157967;9569.61721531131;9766.169875560658;9947.602095916081;9608.519574021131;10039.19686425099;10071.949640251752;10095;10108.646197383056;9902.950485247527;9939.254555908192;10170.135538479311;10306.12397946183;10408.323458975143;7458.328750412489;7549.7357592483995;7550.433717471322;7597.734079307198;7779.37764978789;10458.947705261426;10797.082248009006;10943.671689849318;10954.507047182737;10997.065249453886 17:32:23 INFO - PROCESS | 17762 | |3;mootools.html;1418.8652078052583;1460.6494441334082;1502.3014298351268;1640.130730712722;1804.2963244334712;6429.357064293574;7147.8570428591465;7352.595607241599;7366.079240094989;7385.409167266619;7056.082709247803;7271.4909956302945;7283.635818209094;7284.380827629658;7298.854022919539;2102.6320393931037;2133.3173384516963;2134.4130364149905;2136.668816333463;2137.9465513362134;2097.9160833566716;2124.564464284818;2150.204424362988;2150.3226483657677;2161.945951351213;2125.6280150973594;2139.743230812305;2149.978500215001;2151.6449785785326;2152.2789865395034;2113.365990202941;2117.98941005294;2119.1841141160685;2119.523107300845;2119.5442979759428;2042.5914817036503;2087.65553683642;2098.370488853338;2099.611571859211;2104.116271166114;7026.859462810767;7261.818454538626;7355.227701091415;7393.07586551681;7397.075365579302;4284.121755040209;4381.211381951248;4438.178936896685;4439.311906654474;4448.555144485558;2744.3962328287944;2767.640206773127;2818.182727009165;2827;2886.480433521965;885.9468431894043;897.0625696147476;899.8830152080253;902.2736696958946;938.1884669760608;9816.754581135458;9928.305018648698;9931.056549627774;9955.75110622233;9972.202223822076;3895.14306852492;3967.3255546557157;4012.558618551957;4014.879553613396;4040.5151381834366;7753.069631644126;7792.337651299703;7800.414968877357;7810.531368117931;7816.006918235814;4419.801108950105;4442.955570444319;4467.910641787146;4474.709143905701;4482.798274077674;3499.2126771476724;4013.8595149169637;4119.958800411958;4169.770662613525;4217.894552636148;3202.1674364665355;3216.388886111631;3305.289362787012;3324.9833750831576;3327.1183136468853;951.1344676344631;968.3705591365668;979.3829887171179;982.1798798003604;992.3256822862317;869.9434536755091;877.5392918717724;878.4553576782436;879.2877769007125;884.5311984648018;4901.656884018084;4922.803087876445;5015.04714104319;5021.899562008813;5091.058154241403;425.9041715614024;427.9614834664895;429.88178250980604;433.00841073940325;918.4122161816442;3467.8439470223902;3495.563054618173;3537;3619.475176099451;3924.9215015700097;8867.822643547093;9117.36178467501;9194.724158275263;9226.76933076665;9233.076692330713;9039.412438191497;9046.81906361869;9132.949710783212;9170.81658366829;9181.862272065924;6922.723091076401;7080.256573059754;7100.715971361088;7146.392556632744;7154.713811447588;5314.760835762323;5369.704666243238;5371.328583927009;5437.10287802524;5527.972360138174;8215.260626543639;8216.424850260424;8262.958685206535;8454.492730436194;8529.616167272612;8522.147785221428;8532.573371331533;8541.316694664536;8557.101504341954;8563.657453701782;5226.608004399609;5959.28488581373;5965.105234214902;6099.786507472217;6102.938970610237;7110.075690160453;7160.069191005136;7186.748463803742;7187;7187.425005999403;6424.196975378078;6590.9670451647435;6599.175103112111;6658.7336506539195;6667.799966001027;6338.302786693553;6472.255690595642;6481.643509607017;6565.835854103495;6589.835254118685;6005.849853753691;6170.043643235305;6214.937850621617;6217.689115544114;6226.937730622636;4480;4615.699979501322;4619.7690115493415;4649.628029757679;4678.181318269358;4517.909641807211;4548.818047278071;4559.110973360163;4572.35986961819;4632.3977882875015 17:32:23 INFO - PROCESS | 17762 | |4;prototype.html;296.6692138265833;299.2294840784979;300.2763340349758;301.4618905254122;305.25213227592405;4700.811967521299;4734.834280800173;4773.427188737348;4776.546228108328;4791.233402655567;4678.415198100238;4690.859274221779;4697.647676424273;4698.553637404441;4712.90574188516;3556.270964452281;3624.8912532624063;3697.038769919827;3746.7189960752917;3791.867284645038;3740.8690695825517;3747.6439738224963;3753.4369844523267;3753.831077601501;3756.4928734620885;3522.5557521416094;3727.180020395522;3737.5514938207452;3749.325121478133;3755.3428150073764;3636.8727094551564;3709.647583479565;3730.2725968436166;3743.737938344317;3748.4564738113095;3312.403767321881;3321.80069195849;3325.817080060596;3334.583177102862;3337.5327454156436;4520.389747384094;4527.366168736379;4544.068770772408;4544.681872268942;4558.680892337537;3995.260876737813;4241.766702831343;4246.363045543162;4246.617804397619;4260.659147268211;4930.506949305077;4935.753212339405;4951.480094590052;4965.602751779849;4970.329005584236;3594.993401847487;3617.258462015307;3621.3662609043577;3621.4024685926793;3638.181409182939;5019.62352823536;5080.288759573663;5142.511461411197;5161.793528258865;5167.121589329823;3674.9448758268645;3675.3568125577917;3683.1160521474653;3696.519452471215;3697.630236976335;3729.645683660048;3737.6544444000137;3737.8691745788765;3740.345439548068;3768.453574231721;4230.455883602463;4230.957690423118;4234.449521562239;4241.257779888507;4255.489341279066;4786.95213047872;4929.211326187865;4949.356583644103;4963.230699241623;4980.77586508608;1355.5187908292612;1367.7606418876658;1369.500132451648;1369.7945308203848;1369.9178049317072;863.1023735315201;922.3128769067088;924.2698268368049;943.8065196634674;950.6387572722459;4568.246239370533;4589.747563884019;4592.2422800238255;4594.5864872161;4596.908061838744;5344.946550534445;5348.3849357323625;5358.892822143535;5366;5377.946220537745;4460.241758900995;4541.227991241497;4549.818007279738;4555.886102847389;4566.13243483737;2834.9433011339656;2865.592901962362;2870.598116263725;2877.741003309712;2879.3665393613373;5023.1711767557945;5034.496550345009;5046;5084.059449001947;5100.821471248489;5363.704996225245;5444.972775136099;5473.917891231635;5485.862853428696;5504.119340905436;5024.974875125601;5033.245013247969;5038.748062596856;5041.571466425395;5052.242163675478;5326.813561525483;5330.840074797762;5334.626576139788;5340.279062326692;5375.113106337567;5037.5214354636255;5227.81702640421;5228.869278268074;5234.738263086907;5251.973740131275;5009.774560144875;5019.498050195098;5036.29491871131;5040.596752259884;5044.672096313728;3887.9222415550967;3889.521981646956;3899.980500097481;3902.1025164211824;3904.4338570907626;4829.613630909589;5095.312132862165;5120.615953803405;5120.641555091257;5364.4099149094345;4952.548488498072;4964.578010869117;4972.328735620645;4973.651844370859;4985.557077032156;4939.481354457874;4954.677945933503;4961.330220420341;4982.601391888567;4986.975065124651;4687.250039993584;4771.260454629538;4909.214525675875;4934.01492097276;4934.55588996992;4907.926381104215;4959.181735013683;5007.799688012585;5011.649184557046;5032.169692000925;4910.607151427806;4915.827946021872;4929.383827021622;4930.087933732271;4934.5805606523845 17:32:23 INFO - PROCESS | 17762 | |5;yui.html;641.9390157934997;671.2347923367362;703.7220297982298;730.9926900730998;792.2236208515654;12174.695632609179;12606.558770443025;12609.495620175194;12630.621081367552;12643.05177111718;11133.276337038107;11174.497147628355;11213.495392707327;11338.263012904155;12209.755804883896;697.7174244430988;867.9913200867974;881.960311785968;882.2809410330592;882.74400423877;835.7325655790149;886.5478605911;889.2930120554142;890.5102193793421;891.2647066170402;927.8747369105185;929.3262384771054;929.45162354211;929.7443203119128;930.2093220762365;720.8882623193414;885.7962668586197;926.865604487349;927.4759760735196;927.777333439973;670.0752960913908;670.6043434373743;670.6747227594612;670.9429698475586;672.5628341577965;12866.549670761478;12879.67800804978;12885.226886386754;12955.417006234742;12975.545855895092;12525.43635536394;13063.085584009123;13183.14309569875;13224.140430871963;13355.399007044707;10123.341982771097;10152.79694406115;10269.794604107876;10484.266101372907;10633.36199828005;3359.5632567766033;3371.96628033719;3436.914077148066;3453.171238902645;3521.40136176848;43580.346294805604;44244.55755442436;44566;45289.320660190126;45830;9885.310478429114;9900.356476828983;10032.79934401308;10191.54138063789;10326.173906087495;16867.91566042162;17019.744703829452;17032.148392580322;17043.23305451233;17062.82937170637;6424.486041116699;6521.804345869631;6768.898466523006;6931.306869313129;7131.322524360177;3762.172322089136;3816.8282427290837;3827.483289755847;3835.3671644178958;3838.0404898775305;2933.4426458972725;2950.4246671899205;2954.542045982876;2956.1870485616196;2962.1113665900143;532.4622131646987;534.8689571055116;535.7348112684247;537.8494021673938;549.3325609384617;533.786485405833;633.3318349141608;646.5991085527004;657.9111819904251;676.4858707382326;7598.772036838904;7983.600819958979;8023.117457079717;8122.837543249102;8221.506709597443;589.7287247866029;624.7750809708501;629.645997924348;654.8133781872239;662.6786008785735;3667.5232219811787;3710.9257814843554;3719.3119272934596;3720.9627903721157;3828.559715632738;51596.22605660918;52452.21321680178;53600;53705;53883;36021.81989090038;36440.635593644256;40568.79715601403;46352.07295854064;49090.26364604462;44161.77919110384;44426.333604995954;45543.316850247276;45548.54451455509;46187.307190392174;7297.343239108293;7356.77929662111;7400.5189662671755;7448.925510744823;7611.124720657195;28960.855195723885;29353.55969660414;29390;29917.55123673103;30621.23446913756;37742.62257377391;37914;38369.4244586337;38472.230555388174;38886.222275553766;9929.3545919515;10040.246981476565;10399.376037437778;10414.47927603632;10749.086327662237;11563.30620162793;11683.415829208676;11703.356315402394;12066.276023438622;12342.81485777732;10782.514786834454;11052.834207486734;11256.943715281372;11424.028957538701;11480.770384592428;11229.38238396896;11533.826992595286;11597.88402115968;11906.464209110438;11973.102017348909;10138.746531336776;10140.188784897338;10523.210759192938;10809.243352965532;10830.783384332426;9444.150026497648;9505.904940950502;9559.23526117895;9828.16460600857;9932.205423566242;9453.572225113265;9484.810303793747;9639.614415423304;9909.752256193653;9923.55344009507 17:32:23 INFO - PROCESS | 17762 | __end_tp_report 17:32:23 INFO - PROCESS | 17762 | __start_cc_report 17:32:23 INFO - PROCESS | 17762 | _x_x_mozilla_cycle_collect,1125 17:32:23 INFO - PROCESS | 17762 | __end_cc_report 17:32:23 INFO - PROCESS | 17762 | __startTimestamp1462408343582__endTimestamp 17:32:23 INFO - PROCESS | 17762 | 17:32:23 INFO - PROCESS | 17762 | ------- Summary: start ------- 17:32:23 INFO - PROCESS | 17762 | Number of tests: 6 17:32:23 INFO - PROCESS | 17762 | 17:32:23 INFO - PROCESS | 17762 | [#0] dojo.html Cycles:165 Average:4573.04 Median:4670.84 stddev:476.26 (10.2%) stddev-sans-first:450.95 17:32:23 INFO - PROCESS | 17762 | Values: 2566.3 2584.7 2618.3 2625.5 2626.9 4552.7 4577.0 4586.0 4647.7 4670.8 4572.1 4626.7 4630.8 4650.7 4687.7 4211.7 4224.8 4253.2 4286.0 4394.8 4332.5 4362.7 4389.6 4410.1 4410.7 4225.2 4295.0 4302.4 4305.9 4323.3 4253.6 4265.7 4278.6 4281.6 4281.7 4241.3 4241.6 4247.7 4255.3 4255.6 4486.2 4505.9 4522.7 4557.8 4599.0 4985.8 4998.6 5015.5 5065.4 5067.1 4853.2 5016.6 5026.0 5040.3 5045.3 4521.5 4559.5 4560.1 4597.6 4609.7 4954.4 4979.0 4986.0 4993.3 5011.1 4775.4 4784.1 4786.0 4800.6 4855.3 4921.3 4953.1 4982.9 4998.0 5003.5 4883.2 4892.2 4895.3 4896.3 4941.9 4821.7 4877.1 4890.4 4890.9 4941.1 4104.1 4155.0 4187.9 4207.3 4230.2 3635.2 3636.7 3641.0 3677.6 3681.8 4174.4 4189.7 4197.6 4233.4 4247.0 4950.0 4980.7 4992.0 5027.7 5034.5 4223.6 4252.7 4253.5 4256.7 4296.6 4386.1 4483.6 4486.5 4503.0 4523.4 4619.6 4655.3 4658.2 4664.1 4664.4 4892.5 4896.5 4900.1 4902.7 4944.4 4518.1 4628.5 4630.1 4634.1 4677.2 4866.5 4886.0 4900.4 4927.0 4943.3 4948.3 4955.2 4957.9 4965.4 5011.4 4736.5 4770.3 4821.7 4827.6 4874.0 4847.8 4850.7 4878.3 4879.1 4927.2 4809.1 4813.9 4829.6 4831.7 4851.3 4752.2 4858.5 4938.0 4945.8 4973.9 4671.7 4691.9 4697.1 4727.9 4746.0 17:32:23 INFO - PROCESS | 17762 | 17:32:23 INFO - PROCESS | 17762 | [#1] ext.html Cycles:180 Average:47799.73 Median:352944.50 stddev:82584.20 (23.4%) stddev-sans-first:82739.84 17:32:23 INFO - PROCESS | 17762 | Values: 603.3 611.3 617.6 628.0 629.2 27022.6 34717.0 34768.3 35813.5 36025.0 38046.2 38820.4 38855.8 38937.2 38963.4 7294.3 7567.4 7884.2 7925.2 7930.1 9639.7 9867.2 9920.4 9927.0 9929.7 9805.4 9977.2 9981.2 9989.0 9996.2 9968.4 10117.5 10139.1 10141.0 10141.3 9970.6 10047.6 10089.5 10342.3 10368.6 37852.2 38320.0 38329.0 38372.2 38435.0 3285.9 3380.7 3406.5 3550.6 3895.3 29940.0 30019.4 30036.4 30319.2 31377.2 2999.4 3014.4 3041.7 3091.8 3140.4 254181.0 255182.0 255217.0 255302.0 255827.0 55676.0 56160.4 56193.7 56237.7 56241.0 59303.4 59387.0 59530.4 59602.4 59685.0 13437.2 13748.5 13879.2 13895.3 13922.4 10186.5 10196.7 10216.8 10222.7 10225.7 16010.8 16577.6 16721.6 16780.2 16788.2 6601.0 6683.6 6687.4 6696.6 6799.5 946.3 974.9 997.7 1005.3 1043.5 28840.6 28936.9 29069.7 29472.3 29629.7 944.9 1019.8 1068.4 1069.2 1078.8 15520.9 15530.7 15609.6 15627.3 15721.4 345519.0 352182.0 352658.0 353231.0 353787.0 50499.2 51482.2 51570.7 51578.0 51591.7 1177.6 1234.8 1284.3 1288.1 1318.1 28348.3 30155.2 30180.7 31154.2 31179.7 45247.8 47169.3 47256.0 47301.3 47310.3 320069.0 332479.0 332489.0 332770.0 333695.0 30204.2 35643.3 36087.5 36685.8 37032.3 41007.0 41544.6 41661.4 42206.6 43985.3 37736.2 38243.4 38324.6 38699.2 39146.7 31992.5 33091.0 37450.0 37811.0 38005.0 36892.1 37008.3 37381.3 37511.0 37981.4 32567.0 33779.0 34120.3 34386.0 34414.3 25630.7 25739.7 26037.6 26322.6 26477.7 17:32:23 INFO - PROCESS | 17762 | 17:32:23 INFO - PROCESS | 17762 | [#2] jquery.html Cycles:180 Average:22131.71 Median:23996.34 stddev:54481.58 (227.0%) stddev-sans-first:54609.93 17:32:23 INFO - PROCESS | 17762 | Values: 375.6 376.5 378.4 385.5 388.2 16062.5 16632.2 17436.7 17462.7 17469.9 16186.3 16768.2 16869.7 16938.8 16949.2 3492.8 4691.5 4919.9 4923.3 4926.9 3664.9 5295.6 5561.6 5563.3 5570.6 5249.4 5526.7 5538.7 5540.8 5542.6 3483.7 5477.1 5515.1 5518.2 5522.8 5132.3 5392.6 5395.0 5398.1 5400.0 12071.2 12283.3 15585.5 18947.4 19498.5 1881.5 1885.6 1947.8 2109.0 2196.6 9042.5 9278.7 9674.6 11868.5 13175.3 1736.5 1775.4 1805.7 1808.4 1858.3 65785.0 67426.3 67754.7 67868.7 69152.7 9840.7 10134.5 10411.4 10465.3 10599.6 14307.9 14418.7 14423.0 14423.1 14432.3 7025.3 7219.5 7398.5 7429.1 7544.9 7038.4 7047.4 7144.3 7169.6 7198.5 4383.9 4460.9 4465.2 4547.9 4586.4 1726.8 1757.2 1820.2 1833.5 1935.9 884.2 917.6 945.6 972.7 979.0 16234.1 16814.9 17185.6 17461.2 17722.0 935.0 950.0 958.7 966.5 1009.6 9475.4 9508.7 9731.6 9790.5 9872.3 302044.0 305238.0 307684.0 309092.0 400767.0 77265.6 79453.6 81297.6 81556.0 82132.0 965.7 988.9 1011.3 1012.9 1020.1 15490.7 15789.0 15794.9 16041.5 16411.4 24974.8 30103.7 35516.6 36162.1 36987.1 42501.8 43608.8 44110.3 44491.1 44550.0 7268.5 7500.2 7515.3 7537.2 7574.8 9886.0 10911.3 11006.8 11077.2 11292.3 8913.2 9295.2 9569.6 9766.2 9947.6 9608.5 10039.2 10071.9 10095.0 10108.6 9903.0 9939.3 10170.1 10306.1 10408.3 7458.3 7549.7 7550.4 7597.7 7779.4 10458.9 10797.1 10943.7 10954.5 10997.1 17:32:23 INFO - PROCESS | 17762 | 17:32:23 INFO - PROCESS | 17762 | [#3] mootools.html Cycles:180 Average:4873.16 Median:5962.20 stddev:2676.02 (44.9%) stddev-sans-first:2670.94 17:32:23 INFO - PROCESS | 17762 | Values: 1418.9 1460.6 1502.3 1640.1 1804.3 6429.4 7147.9 7352.6 7366.1 7385.4 7056.1 7271.5 7283.6 7284.4 7298.9 2102.6 2133.3 2134.4 2136.7 2137.9 2097.9 2124.6 2150.2 2150.3 2161.9 2125.6 2139.7 2150.0 2151.6 2152.3 2113.4 2118.0 2119.2 2119.5 2119.5 2042.6 2087.7 2098.4 2099.6 2104.1 7026.9 7261.8 7355.2 7393.1 7397.1 4284.1 4381.2 4438.2 4439.3 4448.6 2744.4 2767.6 2818.2 2827.0 2886.5 885.9 897.1 899.9 902.3 938.2 9816.8 9928.3 9931.1 9955.8 9972.2 3895.1 3967.3 4012.6 4014.9 4040.5 7753.1 7792.3 7800.4 7810.5 7816.0 4419.8 4443.0 4467.9 4474.7 4482.8 3499.2 4013.9 4120.0 4169.8 4217.9 3202.2 3216.4 3305.3 3325.0 3327.1 951.1 968.4 979.4 982.2 992.3 869.9 877.5 878.5 879.3 884.5 4901.7 4922.8 5015.0 5021.9 5091.1 425.9 428.0 429.9 433.0 918.4 3467.8 3495.6 3537.0 3619.5 3924.9 8867.8 9117.4 9194.7 9226.8 9233.1 9039.4 9046.8 9132.9 9170.8 9181.9 6922.7 7080.3 7100.7 7146.4 7154.7 5314.8 5369.7 5371.3 5437.1 5528.0 8215.3 8216.4 8263.0 8454.5 8529.6 8522.1 8532.6 8541.3 8557.1 8563.7 5226.6 5959.3 5965.1 6099.8 6102.9 7110.1 7160.1 7186.7 7187.0 7187.4 6424.2 6591.0 6599.2 6658.7 6667.8 6338.3 6472.3 6481.6 6565.8 6589.8 6005.8 6170.0 6214.9 6217.7 6226.9 4480.0 4615.7 4619.8 4649.6 4678.2 4517.9 4548.8 4559.1 4572.4 4632.4 17:32:23 INFO - PROCESS | 17762 | 17:32:23 INFO - PROCESS | 17762 | [#4] prototype.html Cycles:180 Average:4205.00 Median:4706.86 stddev:1207.90 (25.7%) stddev-sans-first:1175.13 17:32:23 INFO - PROCESS | 17762 | Values: 296.7 299.2 300.3 301.5 305.3 4700.8 4734.8 4773.4 4776.5 4791.2 4678.4 4690.9 4697.6 4698.6 4712.9 3556.3 3624.9 3697.0 3746.7 3791.9 3740.9 3747.6 3753.4 3753.8 3756.5 3522.6 3727.2 3737.6 3749.3 3755.3 3636.9 3709.6 3730.3 3743.7 3748.5 3312.4 3321.8 3325.8 3334.6 3337.5 4520.4 4527.4 4544.1 4544.7 4558.7 3995.3 4241.8 4246.4 4246.6 4260.7 4930.5 4935.8 4951.5 4965.6 4970.3 3595.0 3617.3 3621.4 3621.4 3638.2 5019.6 5080.3 5142.5 5161.8 5167.1 3674.9 3675.4 3683.1 3696.5 3697.6 3729.6 3737.7 3737.9 3740.3 3768.5 4230.5 4231.0 4234.4 4241.3 4255.5 4787.0 4929.2 4949.4 4963.2 4980.8 1355.5 1367.8 1369.5 1369.8 1369.9 863.1 922.3 924.3 943.8 950.6 4568.2 4589.7 4592.2 4594.6 4596.9 5344.9 5348.4 5358.9 5366.0 5377.9 4460.2 4541.2 4549.8 4555.9 4566.1 2834.9 2865.6 2870.6 2877.7 2879.4 5023.2 5034.5 5046.0 5084.1 5100.8 5363.7 5445.0 5473.9 5485.9 5504.1 5025.0 5033.2 5038.7 5041.6 5052.2 5326.8 5330.8 5334.6 5340.3 5375.1 5037.5 5227.8 5228.9 5234.7 5252.0 5009.8 5019.5 5036.3 5040.6 5044.7 3887.9 3889.5 3900.0 3902.1 3904.4 4829.6 5095.3 5120.6 5120.6 5364.4 4952.5 4964.6 4972.3 4973.7 4985.6 4939.5 4954.7 4961.3 4982.6 4987.0 4687.3 4771.3 4909.2 4934.0 4934.6 4907.9 4959.2 5007.8 5011.6 5032.2 4910.6 4915.8 4929.4 4930.1 4934.6 17:32:23 INFO - PROCESS | 17762 | 17:32:23 INFO - PROCESS | 17762 | [#5] yui.html Cycles:180 Average:12709.15 Median:43871.06 stddev:14277.54 (32.5%) stddev-sans-first:14288.84 17:32:23 INFO - PROCESS | 17762 | Values: 641.9 671.2 703.7 731.0 792.2 12174.7 12606.6 12609.5 12630.6 12643.1 11133.3 11174.5 11213.5 11338.3 12209.8 697.7 868.0 882.0 882.3 882.7 835.7 886.5 889.3 890.5 891.3 927.9 929.3 929.5 929.7 930.2 720.9 885.8 926.9 927.5 927.8 670.1 670.6 670.7 670.9 672.6 12866.5 12879.7 12885.2 12955.4 12975.5 12525.4 13063.1 13183.1 13224.1 13355.4 10123.3 10152.8 10269.8 10484.3 10633.4 3359.6 3372.0 3436.9 3453.2 3521.4 43580.3 44244.6 44566.0 45289.3 45830.0 9885.3 9900.4 10032.8 10191.5 10326.2 16867.9 17019.7 17032.1 17043.2 17062.8 6424.5 6521.8 6768.9 6931.3 7131.3 3762.2 3816.8 3827.5 3835.4 3838.0 2933.4 2950.4 2954.5 2956.2 2962.1 532.5 534.9 535.7 537.8 549.3 533.8 633.3 646.6 657.9 676.5 7598.8 7983.6 8023.1 8122.8 8221.5 589.7 624.8 629.6 654.8 662.7 3667.5 3710.9 3719.3 3721.0 3828.6 51596.2 52452.2 53600.0 53705.0 53883.0 36021.8 36440.6 40568.8 46352.1 49090.3 44161.8 44426.3 45543.3 45548.5 46187.3 7297.3 7356.8 7400.5 7448.9 7611.1 28960.9 29353.6 29390.0 29917.6 30621.2 37742.6 37914.0 38369.4 38472.2 38886.2 9929.4 10040.2 10399.4 10414.5 10749.1 11563.3 11683.4 11703.4 12066.3 12342.8 10782.5 11052.8 11256.9 11424.0 11480.8 11229.4 11533.8 11597.9 11906.5 11973.1 10138.7 10140.2 10523.2 10809.2 10830.8 9444.2 9505.9 9559.2 9828.2 9932.2 9453.6 9484.8 9639.6 9909.8 9923.6 17:32:23 INFO - PROCESS | 17762 | -------- Summary: end -------- 17:32:23 INFO - PROCESS | 17762 | 17:32:24 INFO - TEST-INFO | 17762: exit 0 17:32:24 INFO - TEST-OK | dromaeo_css | took 1118979ms 17:32:24 INFO - TEST-START | kraken 17:32:24 INFO - operating with platform_type : linux_ 17:32:24 INFO - Initialising browser for kraken test... 17:32:24 INFO - TEST-INFO | started process 17946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI7bcGZ/profile http://localhost:53307/getInfo.html) 17:32:28 INFO - PROCESS | 17946 | __metrics Screen width/height:1600/1200 17:32:28 INFO - PROCESS | 17946 | colorDepth:24 17:32:28 INFO - PROCESS | 17946 | Browser inner width/height: 1024/697 17:32:28 INFO - PROCESS | 17946 | __metrics 17:32:29 ERROR - PROCESS | 17946 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:32:30 INFO - TEST-INFO | 17946: exit 0 17:32:30 INFO - Browser initialized. 17:32:30 INFO - Running cycle 1/1 for kraken test... 17:32:30 INFO - TEST-INFO | started process 18027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI7bcGZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:42 INFO - PROCESS | 18027 | RSS: Main: 156364800 17:32:42 INFO - PROCESS | 18027 | 17:32:45 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53307/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:46 INFO - PROCESS | 18027 | RSS: Main: 211517440 17:32:46 INFO - PROCESS | 18027 | 17:32:48 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53307/tests/kraken/driver.html?testName=audio-dft) 17:32:49 INFO - PROCESS | 18027 | RSS: Main: 197836800 17:32:49 INFO - PROCESS | 18027 | 17:32:52 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53307/tests/kraken/driver.html?testName=audio-fft) 17:32:53 INFO - PROCESS | 18027 | RSS: Main: 267366400 17:32:53 INFO - PROCESS | 18027 | 17:32:55 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53307/tests/kraken/driver.html?testName=audio-oscillator) 17:32:56 INFO - PROCESS | 18027 | RSS: Main: 175423488 17:32:56 INFO - PROCESS | 18027 | 17:32:58 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53307/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:59 INFO - PROCESS | 18027 | RSS: Main: 180023296 17:32:59 INFO - PROCESS | 18027 | 17:33:02 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53307/tests/kraken/driver.html?testName=imaging-darkroom) 17:33:02 INFO - PROCESS | 18027 | RSS: Main: 215683072 17:33:02 INFO - PROCESS | 18027 | 17:33:06 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53307/tests/kraken/driver.html?testName=imaging-desaturate) 17:33:06 INFO - PROCESS | 18027 | RSS: Main: 217051136 17:33:06 INFO - PROCESS | 18027 | 17:33:09 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53307/tests/kraken/driver.html?testName=json-parse-financial) 17:33:10 INFO - PROCESS | 18027 | RSS: Main: 216768512 17:33:10 INFO - PROCESS | 18027 | 17:33:12 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53307/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:33:12 INFO - PROCESS | 18027 | RSS: Main: 202084352 17:33:12 INFO - PROCESS | 18027 | 17:33:14 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53307/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:33:15 INFO - PROCESS | 18027 | RSS: Main: 206614528 17:33:15 INFO - PROCESS | 18027 | 17:33:17 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53307/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:33:18 INFO - PROCESS | 18027 | RSS: Main: 218808320 17:33:18 INFO - PROCESS | 18027 | 17:33:20 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:21 INFO - PROCESS | 18027 | RSS: Main: 224473088 17:33:21 INFO - PROCESS | 18027 | 17:33:24 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:25 INFO - PROCESS | 18027 | RSS: Main: 219860992 17:33:25 INFO - PROCESS | 18027 | 17:33:26 INFO - PROCESS | 18027 | Cycle 1(1): loaded http://localhost:53307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53307/tests/kraken/driver.html?testName=ai-astar) 17:33:27 INFO - PROCESS | 18027 | RSS: Main: 283271168 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | __start_tp_report 17:33:27 INFO - PROCESS | 18027 | _x_x_mozilla_page_load 17:33:27 INFO - PROCESS | 18027 | _x_x_mozilla_page_load_details 17:33:27 INFO - PROCESS | 18027 | |i|pagename|runs| 17:33:27 INFO - PROCESS | 18027 | |0;ai-astar;113;116;109;115;115;115;101;114;112;112 17:33:27 INFO - PROCESS | 18027 | |1;audio-beat-detection;163;133;162;189;133;154;162;132;188;132 17:33:27 INFO - PROCESS | 18027 | |2;audio-dft;160;166;161;161;162;161;162;162;160;163 17:33:27 INFO - PROCESS | 18027 | |3;audio-fft;74;74;123;113;74;75;74;117;107;74 17:33:27 INFO - PROCESS | 18027 | |4;audio-oscillator;95;96;151;95;94;94;140;94;94;140 17:33:27 INFO - PROCESS | 18027 | |5;imaging-gaussian-blur;117;117;117;117;117;116;119;117;116;117 17:33:27 INFO - PROCESS | 18027 | |6;imaging-darkroom;146;147;145;146;145;146;145;145;146;147 17:33:27 INFO - PROCESS | 18027 | |7;imaging-desaturate;94;95;94;95;95;95;96;96;96;95 17:33:27 INFO - PROCESS | 18027 | |8;json-parse-financial;66;67;67;68;68;68;67;87;66;65 17:33:27 INFO - PROCESS | 18027 | |9;json-stringify-tinderbox;65;65;65;64;71;64;65;64;64;64 17:33:27 INFO - PROCESS | 18027 | |10;stanford-crypto-aes;86;79;79;78;91;88;81;82;83;82 17:33:27 INFO - PROCESS | 18027 | |11;stanford-crypto-ccm;131;143;137;129;136;138;131;129;175;133 17:33:27 INFO - PROCESS | 18027 | |12;stanford-crypto-pbkdf2;180;178;179;179;186;179;179;180;177;180 17:33:27 INFO - PROCESS | 18027 | |13;stanford-crypto-sha256-iterative;74;73;81;72;71;72;72;72;73;72 17:33:27 INFO - PROCESS | 18027 | __end_tp_report 17:33:27 INFO - PROCESS | 18027 | __start_cc_report 17:33:27 INFO - PROCESS | 18027 | _x_x_mozilla_cycle_collect,1879 17:33:27 INFO - PROCESS | 18027 | __end_cc_report 17:33:27 INFO - PROCESS | 18027 | __startTimestamp1462408407195__endTimestamp 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | ------- Summary: start ------- 17:33:27 INFO - PROCESS | 18027 | Number of tests: 14 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#0] ai-astar Cycles:10 Average:112.20 Median:114.50 stddev:4.44 (3.9%) stddev-sans-first:4.70 17:33:27 INFO - PROCESS | 18027 | Values: 113.0 116.0 109.0 115.0 115.0 115.0 101.0 114.0 112.0 112.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:162.00 stddev:22.20 (13.7%) stddev-sans-first:23.34 17:33:27 INFO - PROCESS | 18027 | Values: 163.0 133.0 162.0 189.0 133.0 154.0 162.0 132.0 188.0 132.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.75 (1.1%) stddev-sans-first:1.73 17:33:27 INFO - PROCESS | 18027 | Values: 160.0 166.0 161.0 161.0 162.0 161.0 162.0 162.0 160.0 163.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#3] audio-fft Cycles:10 Average:90.50 Median:74.00 stddev:21.44 (29.0%) stddev-sans-first:21.90 17:33:27 INFO - PROCESS | 18027 | Values: 74.0 74.0 123.0 113.0 74.0 75.0 74.0 117.0 107.0 74.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:94.00 stddev:23.91 (25.4%) stddev-sans-first:24.80 17:33:27 INFO - PROCESS | 18027 | Values: 95.0 96.0 151.0 95.0 94.0 94.0 140.0 94.0 94.0 140.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 17:33:27 INFO - PROCESS | 18027 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 119.0 117.0 116.0 117.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:33:27 INFO - PROCESS | 18027 | Values: 146.0 147.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 147.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 17:33:27 INFO - PROCESS | 18027 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:67.50 stddev:6.44 (9.5%) stddev-sans-first:6.74 17:33:27 INFO - PROCESS | 18027 | Values: 66.0 67.0 67.0 68.0 68.0 68.0 67.0 87.0 66.0 65.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:2.13 (3.3%) stddev-sans-first:2.26 17:33:27 INFO - PROCESS | 18027 | Values: 65.0 65.0 65.0 64.0 71.0 64.0 65.0 64.0 64.0 64.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.50 stddev:4.23 (5.1%) stddev-sans-first:4.33 17:33:27 INFO - PROCESS | 18027 | Values: 86.0 79.0 79.0 78.0 91.0 88.0 81.0 82.0 83.0 82.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:136.50 stddev:13.68 (10.0%) stddev-sans-first:14.26 17:33:27 INFO - PROCESS | 18027 | Values: 131.0 143.0 137.0 129.0 136.0 138.0 131.0 129.0 175.0 133.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:179.50 stddev:2.41 (1.3%) stddev-sans-first:2.55 17:33:27 INFO - PROCESS | 18027 | Values: 180.0 178.0 179.0 179.0 186.0 179.0 179.0 180.0 177.0 180.0 17:33:27 INFO - PROCESS | 18027 | 17:33:27 INFO - PROCESS | 18027 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:72.50 stddev:2.86 (3.9%) stddev-sans-first:3.02 17:33:27 INFO - PROCESS | 18027 | Values: 74.0 73.0 81.0 72.0 71.0 72.0 72.0 72.0 73.0 72.0 17:33:27 INFO - PROCESS | 18027 | -------- Summary: end -------- 17:33:27 INFO - PROCESS | 18027 | 17:33:28 INFO - TEST-INFO | 18027: exit 0 17:33:28 INFO - TEST-OK | kraken | took 63867ms 17:33:28 INFO - SUITE-END | took 1182s 17:33:28 INFO - Completed test suite (00:19:42) 17:33:28 INFO - javascript benchmark 17:33:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.255785822111, 2584.728603496634, 2618.3192369983813, 2625.488029834182, 2626.8555229462377, 4552.726836389819, 4577.0, 4585.977070114649, 4647.721136731799, 4670.836520721776, 4572.108438854417, 4626.699264547802, 4630.837920672777, 4650.720956742598, 4687.671862969593, 4211.7051806373565, 4224.788760561975, 4253.1706317268145, 4285.9571404286025, 4394.846180383687, 4332.523422423531, 4362.716423432466, 4389.626881715058, 4410.140022695576, 4410.71330363527, 4225.239456897757, 4294.957050429518, 4302.354646802974, 4305.870823875289, 4323.286657701476, 4253.553376895412, 4265.7440553566885, 4278.572142785696, 4281.571842815724, 4281.657467402601, 4241.27898257297, 4241.597048280409, 4247.702660813744, 4255.319148936186, 4255.5744425557505, 4486.170058539181, 4505.887352816206, 4522.7286362818, 4557.79489922951, 4598.977005114986, 4985.803407182287, 4998.600111991068, 5015.498450154992, 5065.392152941634, 5067.138586440277, 4853.150698627761, 5016.648834581544, 5025.974870125626, 5040.294358789773, 5045.344105266328, 4521.502634710212, 4559.452865656142, 4560.087982403533, 4597.632189424838, 4609.700369475973, 4954.380702412199, 4979.0, 4986.0277245936695, 4993.251012348177, 5011.148104822116, 4775.42694876617, 4784.138855006063, 4786.0, 4800.567948884617, 4855.344528488679, 4921.311016457699, 4953.133201689762, 4982.878852258285, 4998.0, 5003.524665156804, 4883.169861123618, 4892.156764802819, 4895.290182923527, 4896.290037944478, 4941.925871111936, 4821.662483626113, 4877.073356062337, 4890.437599676012, 4890.902181956341, 4941.135301322254, 4104.138130992525, 4154.958450415517, 4187.895302617398, 4207.326827707613, 4230.15396920611, 3635.2366003139637, 3636.6908812751212, 3641.0, 3677.6138505457075, 3681.815909204529, 4174.3947127666315, 4189.664826813848, 4197.580241975778, 4233.428487154195, 4247.0444150066605, 4950.0, 4980.726060066731, 4992.026554821775, 5027.698338099725, 5034.496550345009, 4223.598758117974, 4252.744835309892, 4253.48958125027, 4256.6807489438415, 4296.634786043159, 4386.1447017831215, 4483.574060464251, 4486.484054333793, 4503.031848152597, 4523.434570678665, 4619.5611416915335, 4655.324977878188, 4658.161530924466, 4664.090502352009, 4664.39362882823, 4892.486288939753, 4896.534829191221, 4900.14247506692, 4902.7058376497525, 4944.431390390151, 4518.096380723802, 4628.5371462853445, 4630.07398520304, 4634.073185362873, 4677.204875171161, 4866.48901865299, 4885.975570122127, 4900.387451568554, 4927.0, 4943.30793688891, 4948.331975183304, 4955.231939049453, 4957.851264462072, 4965.379327584052, 5011.398632164163, 4736.50266722003, 4770.332153498443, 4821.686590371614, 4827.61379089679, 4874.025194960951, 4847.757612119451, 4850.660453768202, 4878.341423907869, 4879.146149423907, 4927.162382394929, 4809.134355815987, 4813.9037219256115, 4829.637777166797, 4831.710097394168, 4851.32081508582, 4752.239641657318, 4858.5384388483035, 4938.037082768826, 4945.826896058621, 4973.875653108701, 4671.743054131919, 4691.859244222543, 4697.13103075932, 4727.858164255078, 4745.976270118627], "value": 4542.864080010855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.3031848215312, 611.3214332091375, 617.6109051297682, 627.9560430769845, 629.2260519560941, 27022.594661080075, 34717.0, 34768.304633907304, 35813.46279805805, 36025.0, 38046.239075218546, 38820.41769373455, 38855.80572097136, 38937.22125557487, 38963.41554876679, 7294.270572942716, 7567.394608431326, 7884.211578842127, 7925.247101525375, 7930.088039875402, 9639.71080867575, 9867.210623150131, 9920.355176913477, 9927.0, 9929.702108936743, 9805.36265142767, 9977.151942084894, 9981.151602113829, 9989.0, 9996.150327222194, 9968.3520571163, 10117.494125293706, 10139.138173255282, 10141.0, 10141.290109692325, 9970.601175952954, 10047.648332308334, 10089.545970431349, 10342.276040677156, 10368.63709770162, 37852.24295514074, 38320.0, 38329.0, 38372.23255534874, 38435.0, 3285.8685652573868, 3380.6957373836226, 3406.5060566217758, 3550.609432962372, 3895.2793733159456, 29940.0, 30019.399612007855, 30036.399272014438, 30319.242018949702, 31377.215569610715, 2999.4151140527606, 3014.3971205758717, 3041.680623534541, 3091.8144911305394, 3140.434721750084, 254181.0, 255182.0, 255216.99999999814, 255302.0, 255827.0, 55676.0, 56160.43839561634, 56193.71903140458, 56237.718811405684, 56241.0, 59303.40696593065, 59387.0, 59530.404695952486, 59602.403975959685, 59685.0, 13437.193768373929, 13748.450061997408, 13879.236641984788, 13895.305234738222, 13922.443102275998, 10186.541605627765, 10196.694099177037, 10216.846747298796, 10222.744431389276, 10225.74435639115, 16010.759838602431, 16577.585560361087, 16721.581960450843, 16780.160991950353, 16788.160591970354, 6601.0, 6683.598984060972, 6687.431568316651, 6696.59820410777, 6799.524033317719, 946.342292106979, 974.8635191073255, 997.7328792433568, 1005.3415013166388, 1043.4678314059884, 28840.567391489145, 28936.948827164215, 29069.7093029067, 29472.263193420335, 29629.703702962695, 944.9433034017981, 1019.8062368150028, 1068.3643232276784, 1069.2408390043156, 1078.8489611454402, 15520.92239538795, 15530.689386212212, 15609.644041388596, 15627.296771645304, 15721.449749258949, 345519.0, 352182.0, 352658.0, 353231.0, 353787.0, 50499.24251136236, 51482.22776658353, 51570.67931943072, 51578.0, 51591.74204128955, 1177.6349331707197, 1234.8394708687813, 1284.2679672586537, 1288.1176394170025, 1318.1497933832816, 28348.291292717848, 30155.246118847204, 30180.69819301779, 31154.22114447157, 31179.68820311768, 45247.773761130986, 47169.29246061243, 47256.0, 47301.29048064213, 47310.290345644156, 320069.0, 332479.0, 332489.0, 332770.0, 333695.0, 30204.24489387783, 35643.28713425769, 36087.45868811917, 36685.81657091698, 37032.25935481329, 41007.0, 41544.58455415528, 41661.37507937444, 42206.577934220266, 43985.34021989737, 37736.245275094894, 38243.42634860424, 38324.6167538321, 38699.2260154801, 39146.651200928034, 31992.520112198803, 33091.0, 37450.0, 37811.0, 38005.0, 36892.077698057765, 37008.25983480369, 37381.25237495181, 37511.0, 37981.430278546395, 32567.022989310357, 33779.0, 34120.317593648484, 34386.0, 34414.31171376609, 25630.743692562835, 25739.742602574483, 26037.6094358581, 26322.60516092222, 26477.735222648298], "value": 18406.616660060034, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.5755995724834, 376.4672987722372, 378.36812523086445, 385.4642047553901, 388.1828750480239, 16062.518124456255, 16632.168391580417, 17436.738448923275, 17462.65074698505, 17469.91265043673, 16186.271617777198, 16768.245428955695, 16869.662606747857, 16938.83061169388, 16949.152542372893, 3492.7775278652393, 4691.50739172388, 4919.901601967958, 4923.335349727795, 4926.901461970759, 3664.926701465969, 5295.602829787762, 5561.63849349793, 5563.276774019372, 5570.637908535952, 5249.370075590915, 5526.668399895999, 5538.723063846812, 5540.778368865261, 5542.612017158801, 3483.7387195960405, 5477.123660214366, 5515.145152501369, 5518.19986102015, 5522.779088836442, 5132.255822905695, 5392.649477783932, 5394.973025134888, 5398.055340315429, 5400.0, 12071.215371000857, 12283.263004219776, 15585.454509092127, 18947.43157705271, 19498.512537186543, 1881.4731875075001, 1885.604023155139, 1947.8102026735166, 2108.95782084359, 2196.6198951001875, 9042.502662353569, 9278.675246366345, 9674.613015479372, 11868.52525898963, 13175.34123293841, 1736.5484973906748, 1775.3608700867806, 1805.7110862261975, 1808.3761102419644, 1858.256697321069, 65785.0, 67426.3257367425, 67754.66122669405, 67868.6606566969, 69152.6542367285, 9840.704778856645, 10134.493275336205, 10411.427371494641, 10465.26743127989, 10599.629012984662, 14307.85692143086, 14418.711625767426, 14423.0, 14423.062500937405, 14432.257871004476, 7025.332593403618, 7219.494635375473, 7398.482106252511, 7429.14564825052, 7544.886826697604, 7038.401735852408, 7047.365737083687, 7144.3212894774915, 7169.641517924083, 7198.496105272686, 4383.890402739957, 4460.888477788081, 4465.173942820588, 4547.8635640930825, 4586.403767510203, 1726.7927848658242, 1757.1916918217507, 1820.209857166817, 1833.5480597519806, 1935.854810889189, 884.1512148337539, 917.6100157433065, 945.6028468043438, 972.6547075788135, 978.9965285582193, 16234.107124108052, 16814.915925420293, 17185.570360741083, 17461.214245358737, 17722.0, 934.9719508414759, 949.9667511637059, 958.6884262614678, 966.4781018250206, 1009.6415772400838, 9475.384100033476, 9508.714738557854, 9731.610735570639, 9790.510474476248, 9872.259580531489, 302044.0, 305238.0, 307684.0, 309092.0, 400767.0, 77265.61367193128, 79453.61184505731, 81297.59351203206, 81556.0, 82132.0, 965.7006328038331, 988.8862780780158, 1011.2870426349406, 1012.9088382045651, 1020.05644778581, 15490.690186196438, 15789.0, 15794.9210253948, 16041.518754437386, 16411.42560010394, 24974.750252497244, 30103.698963010967, 35516.644833551334, 36162.09594760152, 36987.07532311714, 42501.837233601575, 43608.78195609002, 44110.33834492549, 44491.11017779691, 44550.0, 7268.527545709512, 7500.249975002456, 7515.286047825448, 7537.208593097866, 7574.848503030019, 9886.0, 10911.290766100177, 11006.834897476385, 11077.169212308949, 11292.266002709797, 8913.242374398249, 9295.209907157967, 9569.61721531131, 9766.169875560658, 9947.602095916081, 9608.519574021131, 10039.19686425099, 10071.949640251752, 10095.0, 10108.646197383056, 9902.950485247527, 9939.254555908192, 10170.135538479311, 10306.12397946183, 10408.323458975143, 7458.328750412489, 7549.7357592483995, 7550.433717471322, 7597.734079307198, 7779.37764978789, 10458.947705261426, 10797.082248009006, 10943.671689849318, 10954.507047182737, 10997.065249453886], "value": 8122.078073263112, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.8652078052583, 1460.6494441334082, 1502.3014298351268, 1640.130730712722, 1804.2963244334712, 6429.357064293574, 7147.8570428591465, 7352.595607241599, 7366.079240094989, 7385.409167266619, 7056.082709247803, 7271.4909956302945, 7283.635818209094, 7284.380827629658, 7298.854022919539, 2102.6320393931037, 2133.3173384516963, 2134.4130364149905, 2136.668816333463, 2137.9465513362134, 2097.9160833566716, 2124.564464284818, 2150.204424362988, 2150.3226483657677, 2161.945951351213, 2125.6280150973594, 2139.743230812305, 2149.978500215001, 2151.6449785785326, 2152.2789865395034, 2113.365990202941, 2117.98941005294, 2119.1841141160685, 2119.523107300845, 2119.5442979759428, 2042.5914817036503, 2087.65553683642, 2098.370488853338, 2099.611571859211, 2104.116271166114, 7026.859462810767, 7261.818454538626, 7355.227701091415, 7393.07586551681, 7397.075365579302, 4284.121755040209, 4381.211381951248, 4438.178936896685, 4439.311906654474, 4448.555144485558, 2744.3962328287944, 2767.640206773127, 2818.182727009165, 2827.0, 2886.480433521965, 885.9468431894043, 897.0625696147476, 899.8830152080253, 902.2736696958946, 938.1884669760608, 9816.754581135458, 9928.305018648698, 9931.056549627774, 9955.75110622233, 9972.202223822076, 3895.14306852492, 3967.3255546557157, 4012.558618551957, 4014.879553613396, 4040.5151381834366, 7753.069631644126, 7792.337651299703, 7800.414968877357, 7810.531368117931, 7816.006918235814, 4419.801108950105, 4442.955570444319, 4467.910641787146, 4474.709143905701, 4482.798274077674, 3499.2126771476724, 4013.8595149169637, 4119.958800411958, 4169.770662613525, 4217.894552636148, 3202.1674364665355, 3216.388886111631, 3305.289362787012, 3324.9833750831576, 3327.1183136468853, 951.1344676344631, 968.3705591365668, 979.3829887171179, 982.1798798003604, 992.3256822862317, 869.9434536755091, 877.5392918717724, 878.4553576782436, 879.2877769007125, 884.5311984648018, 4901.656884018084, 4922.803087876445, 5015.04714104319, 5021.899562008813, 5091.058154241403, 425.9041715614024, 427.9614834664895, 429.88178250980604, 433.00841073940325, 918.4122161816442, 3467.8439470223902, 3495.563054618173, 3537.0, 3619.475176099451, 3924.9215015700097, 8867.822643547093, 9117.36178467501, 9194.724158275263, 9226.76933076665, 9233.076692330713, 9039.412438191497, 9046.81906361869, 9132.949710783212, 9170.81658366829, 9181.862272065924, 6922.723091076401, 7080.256573059754, 7100.715971361088, 7146.392556632744, 7154.713811447588, 5314.760835762323, 5369.704666243238, 5371.328583927009, 5437.10287802524, 5527.972360138174, 8215.260626543639, 8216.424850260424, 8262.958685206535, 8454.492730436194, 8529.616167272612, 8522.147785221428, 8532.573371331533, 8541.316694664536, 8557.101504341954, 8563.657453701782, 5226.608004399609, 5959.28488581373, 5965.105234214902, 6099.786507472217, 6102.938970610237, 7110.075690160453, 7160.069191005136, 7186.748463803742, 7187.0, 7187.425005999403, 6424.196975378078, 6590.9670451647435, 6599.175103112111, 6658.7336506539195, 6667.799966001027, 6338.302786693553, 6472.255690595642, 6481.643509607017, 6565.835854103495, 6589.835254118685, 6005.849853753691, 6170.043643235305, 6214.937850621617, 6217.689115544114, 6226.937730622636, 4480.0, 4615.699979501322, 4619.7690115493415, 4649.628029757679, 4678.181318269358, 4517.909641807211, 4548.818047278071, 4559.110973360163, 4572.35986961819, 4632.3977882875015], "value": 3916.3513810788845, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.6692138265833, 299.2294840784979, 300.2763340349758, 301.4618905254122, 305.25213227592405, 4700.811967521299, 4734.834280800173, 4773.427188737348, 4776.546228108328, 4791.233402655567, 4678.415198100238, 4690.859274221779, 4697.647676424273, 4698.553637404441, 4712.90574188516, 3556.270964452281, 3624.8912532624063, 3697.038769919827, 3746.7189960752917, 3791.867284645038, 3740.8690695825517, 3747.6439738224963, 3753.4369844523267, 3753.831077601501, 3756.4928734620885, 3522.5557521416094, 3727.180020395522, 3737.5514938207452, 3749.325121478133, 3755.3428150073764, 3636.8727094551564, 3709.647583479565, 3730.2725968436166, 3743.737938344317, 3748.4564738113095, 3312.403767321881, 3321.80069195849, 3325.817080060596, 3334.583177102862, 3337.5327454156436, 4520.389747384094, 4527.366168736379, 4544.068770772408, 4544.681872268942, 4558.680892337537, 3995.260876737813, 4241.766702831343, 4246.363045543162, 4246.617804397619, 4260.659147268211, 4930.506949305077, 4935.753212339405, 4951.480094590052, 4965.602751779849, 4970.329005584236, 3594.993401847487, 3617.258462015307, 3621.3662609043577, 3621.4024685926793, 3638.181409182939, 5019.62352823536, 5080.288759573663, 5142.511461411197, 5161.793528258865, 5167.121589329823, 3674.9448758268645, 3675.3568125577917, 3683.1160521474653, 3696.519452471215, 3697.630236976335, 3729.645683660048, 3737.6544444000137, 3737.8691745788765, 3740.345439548068, 3768.453574231721, 4230.455883602463, 4230.957690423118, 4234.449521562239, 4241.257779888507, 4255.489341279066, 4786.95213047872, 4929.211326187865, 4949.356583644103, 4963.230699241623, 4980.77586508608, 1355.5187908292612, 1367.7606418876658, 1369.500132451648, 1369.7945308203848, 1369.9178049317072, 863.1023735315201, 922.3128769067088, 924.2698268368049, 943.8065196634674, 950.6387572722459, 4568.246239370533, 4589.747563884019, 4592.2422800238255, 4594.5864872161, 4596.908061838744, 5344.946550534445, 5348.3849357323625, 5358.892822143535, 5366.0, 5377.946220537745, 4460.241758900995, 4541.227991241497, 4549.818007279738, 4555.886102847389, 4566.13243483737, 2834.9433011339656, 2865.592901962362, 2870.598116263725, 2877.741003309712, 2879.3665393613373, 5023.1711767557945, 5034.496550345009, 5046.0, 5084.059449001947, 5100.821471248489, 5363.704996225245, 5444.972775136099, 5473.917891231635, 5485.862853428696, 5504.119340905436, 5024.974875125601, 5033.245013247969, 5038.748062596856, 5041.571466425395, 5052.242163675478, 5326.813561525483, 5330.840074797762, 5334.626576139788, 5340.279062326692, 5375.113106337567, 5037.5214354636255, 5227.81702640421, 5228.869278268074, 5234.738263086907, 5251.973740131275, 5009.774560144875, 5019.498050195098, 5036.29491871131, 5040.596752259884, 5044.672096313728, 3887.9222415550967, 3889.521981646956, 3899.980500097481, 3902.1025164211824, 3904.4338570907626, 4829.613630909589, 5095.312132862165, 5120.615953803405, 5120.641555091257, 5364.4099149094345, 4952.548488498072, 4964.578010869117, 4972.328735620645, 4973.651844370859, 4985.557077032156, 4939.481354457874, 4954.677945933503, 4961.330220420341, 4982.601391888567, 4986.975065124651, 4687.250039993584, 4771.260454629538, 4909.214525675875, 4934.01492097276, 4934.55588996992, 4907.926381104215, 4959.181735013683, 5007.799688012585, 5011.649184557046, 5032.169692000925, 4910.607151427806, 4915.827946021872, 4929.383827021622, 4930.087933732271, 4934.5805606523845], "value": 3828.272806965342, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.9390157934997, 671.2347923367362, 703.7220297982298, 730.9926900730998, 792.2236208515654, 12174.695632609179, 12606.558770443025, 12609.495620175194, 12630.621081367552, 12643.05177111718, 11133.276337038107, 11174.497147628355, 11213.495392707327, 11338.263012904155, 12209.755804883896, 697.7174244430988, 867.9913200867974, 881.960311785968, 882.2809410330592, 882.74400423877, 835.7325655790149, 886.5478605911, 889.2930120554142, 890.5102193793421, 891.2647066170402, 927.8747369105185, 929.3262384771054, 929.45162354211, 929.7443203119128, 930.2093220762365, 720.8882623193414, 885.7962668586197, 926.865604487349, 927.4759760735196, 927.777333439973, 670.0752960913908, 670.6043434373743, 670.6747227594612, 670.9429698475586, 672.5628341577965, 12866.549670761478, 12879.67800804978, 12885.226886386754, 12955.417006234742, 12975.545855895092, 12525.43635536394, 13063.085584009123, 13183.14309569875, 13224.140430871963, 13355.399007044707, 10123.341982771097, 10152.79694406115, 10269.794604107876, 10484.266101372907, 10633.36199828005, 3359.5632567766033, 3371.96628033719, 3436.914077148066, 3453.171238902645, 3521.40136176848, 43580.346294805604, 44244.55755442436, 44566.0, 45289.320660190126, 45830.0, 9885.310478429114, 9900.356476828983, 10032.79934401308, 10191.54138063789, 10326.173906087495, 16867.91566042162, 17019.744703829452, 17032.148392580322, 17043.23305451233, 17062.82937170637, 6424.486041116699, 6521.804345869631, 6768.898466523006, 6931.306869313129, 7131.322524360177, 3762.172322089136, 3816.8282427290837, 3827.483289755847, 3835.3671644178958, 3838.0404898775305, 2933.4426458972725, 2950.4246671899205, 2954.542045982876, 2956.1870485616196, 2962.1113665900143, 532.4622131646987, 534.8689571055116, 535.7348112684247, 537.8494021673938, 549.3325609384617, 533.786485405833, 633.3318349141608, 646.5991085527004, 657.9111819904251, 676.4858707382326, 7598.772036838904, 7983.600819958979, 8023.117457079717, 8122.837543249102, 8221.506709597443, 589.7287247866029, 624.7750809708501, 629.645997924348, 654.8133781872239, 662.6786008785735, 3667.5232219811787, 3710.9257814843554, 3719.3119272934596, 3720.9627903721157, 3828.559715632738, 51596.22605660918, 52452.21321680178, 53600.0, 53705.0, 53883.0, 36021.81989090038, 36440.635593644256, 40568.79715601403, 46352.07295854064, 49090.26364604462, 44161.77919110384, 44426.333604995954, 45543.316850247276, 45548.54451455509, 46187.307190392174, 7297.343239108293, 7356.77929662111, 7400.5189662671755, 7448.925510744823, 7611.124720657195, 28960.855195723885, 29353.55969660414, 29390.0, 29917.55123673103, 30621.23446913756, 37742.62257377391, 37914.0, 38369.4244586337, 38472.230555388174, 38886.222275553766, 9929.3545919515, 10040.246981476565, 10399.376037437778, 10414.47927603632, 10749.086327662237, 11563.30620162793, 11683.415829208676, 11703.356315402394, 12066.276023438622, 12342.81485777732, 10782.514786834454, 11052.834207486734, 11256.943715281372, 11424.028957538701, 11480.770384592428, 11229.38238396896, 11533.826992595286, 11597.88402115968, 11906.464209110438, 11973.102017348909, 10138.746531336776, 10140.188784897338, 10523.210759192938, 10809.243352965532, 10830.783384332426, 9444.150026497648, 9505.904940950502, 9559.23526117895, 9828.16460600857, 9932.205423566242, 9453.572225113265, 9484.810303793747, 9639.614415423304, 9909.752256193653, 9923.55344009507], "value": 6027.01303083911, "unit": "score"}], "name": "dromaeo_css", "value": 6280.6117456, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 109.0, 115.0, 115.0, 115.0, 101.0, 114.0, 112.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 162.0, 189.0, 133.0, 154.0, 162.0, 132.0, 188.0, 132.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 166.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 160.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 123.0, 113.0, 74.0, 75.0, 74.0, 117.0, 107.0, 74.0], "value": 90.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 151.0, 95.0, 94.0, 94.0, 140.0, 94.0, 94.0, 140.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 119.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 87.0, 66.0, 65.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 71.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 79.0, 78.0, 91.0, 88.0, 81.0, 82.0, 83.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 143.0, 137.0, 129.0, 136.0, 138.0, 131.0, 129.0, 175.0, 133.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 178.0, 179.0, 179.0, 186.0, 179.0, 179.0, 180.0, 177.0, 180.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 81.0, 72.0, 71.0, 72.0, 72.0, 72.0, 73.0, 72.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1594.5, "alertThreshold": 2.0}]} 17:33:28 INFO - Return code: 0 17:33:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:33:28 ERROR - # TBPL SUCCESS # 17:33:28 INFO - Running post-action listener: _resource_record_post_action 17:33:28 INFO - Running post-run listener: _resource_record_post_run 17:33:29 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 519503872; Read time: 0; Write time: 524632 17:33:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234950656; Read time: 0; Write time: 264900 17:33:29 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284553216; Read time: 0; Write time: 259732 17:33:29 INFO - Running post-run listener: _upload_blobber_files 17:33:29 INFO - Blob upload gear active. 17:33:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:33:29 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:33:29 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:33:29 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:33:29 INFO - (blobuploader) - INFO - Open directory for files ... 17:33:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:33:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:30 INFO - (blobuploader) - INFO - Done attempting. 17:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:33:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:31 INFO - (blobuploader) - INFO - Done attempting. 17:33:31 INFO - (blobuploader) - INFO - Iteration through files over. 17:33:31 INFO - Return code: 0 17:33:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:33:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:33:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79a1c9142ce42917d7259d0b68a75df4c6944073df5f27c70b5ba78268c7b5cd1c567d375ab748bd4516acc8f16a30643a2691024d11149dd3395f1bbbd66947", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c83440401970da3fd09b4a4b17428e61a44e41e6130585ef9b8786e581a5a6f05eb909000392ba57ff3cbe01976921b81bf0d333a9b4d963e4e4545f4407747"} 17:33:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:33:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:33:31 INFO - Contents: 17:33:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79a1c9142ce42917d7259d0b68a75df4c6944073df5f27c70b5ba78268c7b5cd1c567d375ab748bd4516acc8f16a30643a2691024d11149dd3395f1bbbd66947", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c83440401970da3fd09b4a4b17428e61a44e41e6130585ef9b8786e581a5a6f05eb909000392ba57ff3cbe01976921b81bf0d333a9b4d963e4e4545f4407747"} 17:33:31 INFO - Running post-run listener: copy_logs_to_upload_dir 17:33:31 INFO - Copying logs to upload dir... 17:33:31 INFO - mkdir: /builds/slave/test/build/upload/logs 17:33:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.178587 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-04 17:33:31.259356) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 17:33:31.262896) ========= 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=d2a8c569965ab8367867b893000001a1-1462406181.156839-817949772 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/79a1c9142ce42917d7259d0b68a75df4c6944073df5f27c70b5ba78268c7b5cd1c567d375ab748bd4516acc8f16a30643a2691024d11149dd3395f1bbbd66947", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c83440401970da3fd09b4a4b17428e61a44e41e6130585ef9b8786e581a5a6f05eb909000392ba57ff3cbe01976921b81bf0d333a9b4d963e4e4545f4407747"} build_url:https://queue.taskcluster.net/v1/task/GnOVU3TtTeOMVF9e7mNYZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/GnOVU3TtTeOMVF9e7mNYZg/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/79a1c9142ce42917d7259d0b68a75df4c6944073df5f27c70b5ba78268c7b5cd1c567d375ab748bd4516acc8f16a30643a2691024d11149dd3395f1bbbd66947", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c83440401970da3fd09b4a4b17428e61a44e41e6130585ef9b8786e581a5a6f05eb909000392ba57ff3cbe01976921b81bf0d333a9b4d963e4e4545f4407747"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 17:33:31.287938) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:33:31.288292) ========= 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=d2a8c569965ab8367867b893000001a1-1462406181.156839-817949772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:33:31.371380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 17:33:31.371763) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 17:33:31.372044) ========= ========= Total master_lag: 0.16 =========