builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1462006052.81 results: success (0) buildid: 20160430005741 builduid: 55fdce966b1e4ee9bbc86eabca4f4d13 revision: aea9eee926979ec130fa3a1a32bdcede88b82a35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:32.811631) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:32.812214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:32.812543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:32.857779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:32.858335) ========= 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=cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-30 01:47:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.5M=0s 2016-04-30 01:47:33 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110379 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:32.986378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:32.986715) ========= 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=cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019803 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:33.050418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:33.050772) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aea9eee926979ec130fa3a1a32bdcede88b82a35 --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 aea9eee926979ec130fa3a1a32bdcede88b82a35 --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=cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-30 01:47:33,576 truncating revision to first 12 chars 2016-04-30 01:47:33,576 Setting DEBUG logging. 2016-04-30 01:47:33,576 attempt 1/10 2016-04-30 01:47:33,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aea9eee92697?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-30 01:47:33,856 unpacking tar archive at: fx-team-aea9eee92697/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574241 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:33.649018) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:33.649396) ========= script_repo_revision: aea9eee926979ec130fa3a1a32bdcede88b82a35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:33.649910) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:33.650305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 01:47:33.659731) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-30 01:47:33.660144) ========= /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=cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:47:34 INFO - MultiFileLogger online at 20160430 01:47:34 in /builds/slave/test 01:47:34 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 01:47:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:47:34 INFO - {'append_to_log': False, 01:47:34 INFO - 'base_work_dir': '/builds/slave/test', 01:47:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:47:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:47:34 INFO - 'branch': 'Fx-Team-Non-PGO', 01:47:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:47:34 INFO - 'config_files': ('talos/linux_config.py',), 01:47:34 INFO - 'default_actions': ('clobber', 01:47:34 INFO - 'read-buildbot-config', 01:47:34 INFO - 'download-and-extract', 01:47:34 INFO - 'populate-webroot', 01:47:34 INFO - 'create-virtualenv', 01:47:34 INFO - 'install', 01:47:34 INFO - 'run-tests'), 01:47:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:47:34 INFO - 'download_minidump_stackwalk': True, 01:47:34 INFO - 'download_symbols': 'ondemand', 01:47:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:47:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:47:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:47:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:47:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:47:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:47:34 INFO - 'installer_path': 'installer.exe', 01:47:34 INFO - 'log_level': 'info', 01:47:34 INFO - 'log_name': 'talos', 01:47:34 INFO - 'log_to_console': True, 01:47:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:47:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:47:34 INFO - 'opt_config_files': (), 01:47:34 INFO - 'pip_index': False, 01:47:34 INFO - 'sps_profile': False, 01:47:34 INFO - 'sps_profile_interval': 0, 01:47:34 INFO - 'suite': 'dromaeojs', 01:47:34 INFO - 'system_bits': '32', 01:47:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:47:34 INFO - 'title': 'talos-linux64-ix-054', 01:47:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:47:34 INFO - 'use_talos_json': True, 01:47:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:47:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:47:34 INFO - 'work_dir': 'build'} 01:47:34 INFO - ##### 01:47:34 INFO - ##### Running clobber step. 01:47:34 INFO - ##### 01:47:34 INFO - Running pre-action listener: _resource_record_pre_action 01:47:34 INFO - Running main action method: clobber 01:47:34 INFO - rmtree: /builds/slave/test/build 01:47:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:47:34 INFO - Running post-action listener: _resource_record_post_action 01:47:34 INFO - ##### 01:47:34 INFO - ##### Running read-buildbot-config step. 01:47:34 INFO - ##### 01:47:34 INFO - Running pre-action listener: _resource_record_pre_action 01:47:34 INFO - Running main action method: read_buildbot_config 01:47:34 INFO - Using buildbot properties: 01:47:34 INFO - { 01:47:34 INFO - "project": "", 01:47:34 INFO - "product": "firefox", 01:47:34 INFO - "script_repo_revision": "production", 01:47:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:47:34 INFO - "repository": "", 01:47:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:47:34 INFO - "buildid": "20160430005741", 01:47:34 INFO - "pgo_build": "False", 01:47:34 INFO - "basedir": "/builds/slave/test", 01:47:34 INFO - "buildnumber": 1626, 01:47:34 INFO - "slavename": "talos-linux64-ix-054", 01:47:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:47:34 INFO - "platform": "ubuntu64_hw", 01:47:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:47:34 INFO - "branch": "fx-team", 01:47:34 INFO - "repo_path": "integration/fx-team", 01:47:34 INFO - "revision": "aea9eee926979ec130fa3a1a32bdcede88b82a35", 01:47:34 INFO - "stage_platform": "linux64", 01:47:34 INFO - "builduid": "55fdce966b1e4ee9bbc86eabca4f4d13", 01:47:34 INFO - "slavebuilddir": "test" 01:47:34 INFO - } 01:47:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:47:34 INFO - Running post-action listener: _resource_record_post_action 01:47:34 INFO - ##### 01:47:34 INFO - ##### Running download-and-extract step. 01:47:34 INFO - ##### 01:47:34 INFO - Running pre-action listener: _resource_record_pre_action 01:47:34 INFO - Running main action method: download_and_extract 01:47:34 INFO - mkdir: /builds/slave/test/build/tests 01:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:34 INFO - https://queue.taskcluster.net/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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 01:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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 01:47:35 INFO - Downloaded 1361 bytes. 01:47:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:47:35 INFO - Using the following test package requirements: 01:47:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:47:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:47:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:47:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:35 INFO - u'jsshell-linux-x86_64.zip'], 01:47:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:47:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:47:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:47:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:47:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:47:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:47:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:47:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:35 INFO - https://queue.taskcluster.net/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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 01:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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 01:47:36 INFO - Downloaded 22304506 bytes. 01:47:36 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'] 01:47:36 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 01:47:37 INFO - Return code: 0 01:47:37 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 01:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:37 INFO - https://queue.taskcluster.net/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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 01:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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 01:47:39 INFO - Downloaded 22304506 bytes. 01:47: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'] 01:47: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 01:47:40 INFO - Return code: 0 01:47: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')]} 01:47:40 INFO - https://queue.taskcluster.net/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:47:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:47:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:47:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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 01:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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 01:47:41 INFO - Downloaded 10840152 bytes. 01:47:41 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'] 01:47:41 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 01:47:42 INFO - Return code: 0 01:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:42 INFO - https://queue.taskcluster.net/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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 01:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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 01:47:44 INFO - Downloaded 54911277 bytes. 01:47:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:47:44 INFO - mkdir: /builds/slave/test/properties 01:47:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:47:44 INFO - Writing to file /builds/slave/test/properties/build_url 01:47:44 INFO - Contents: 01:47:44 INFO - build_url:https://queue.taskcluster.net/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:47:45 INFO - Running post-action listener: _resource_record_post_action 01:47:45 INFO - Running post-action listener: set_extra_try_arguments 01:47:45 INFO - ##### 01:47:45 INFO - ##### Running populate-webroot step. 01:47:45 INFO - ##### 01:47:45 INFO - Running pre-action listener: _resource_record_pre_action 01:47:45 INFO - Running main action method: populate_webroot 01:47:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:47:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:47:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:47:45 INFO - '--tppagecycles', 01:47:45 INFO - '7'], 01:47:45 INFO - 'tests': ['tsvgm']}}, 01:47:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:47:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:47:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:47:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:47:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:47:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:47:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'talos_options': ['--disable-e10s'], 01:47:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'talos_options': ['--disable-e10s'], 01:47:45 INFO - 'tests': ['damp', 'tps']}, 01:47:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'tests': ['damp', 'tps']}, 01:47:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:47:45 INFO - 'tests': ['dromaeo_dom']}, 01:47:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:47:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:47:45 INFO - 'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore', 01:47:45 INFO - 'tabpaint']}, 01:47:45 INFO - 'other-e10s': {'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore', 01:47:45 INFO - 'tabpaint']}, 01:47:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore', 01:47:45 INFO - 'tabpaint']}, 01:47:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore', 01:47:45 INFO - 'tabpaint']}, 01:47:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:47:45 INFO - 'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore', 01:47:45 INFO - 'tabpaint']}, 01:47:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:47:45 INFO - 'tests': ['a11yr', 01:47:45 INFO - 'ts_paint', 01:47:45 INFO - 'tpaint', 01:47:45 INFO - 'sessionrestore', 01:47:45 INFO - 'sessionrestore_no_auto_restore', 01:47:45 INFO - 'tabpaint']}, 01:47:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:47:45 INFO - 'tests': ['tsvgx', 01:47:45 INFO - 'tsvgr_opacity', 01:47:45 INFO - 'tart', 01:47:45 INFO - 'tscrollx', 01:47:45 INFO - 'cart']}, 01:47:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:47:45 INFO - 'tsvgr_opacity', 01:47:45 INFO - 'tart', 01:47:45 INFO - 'tscrollx', 01:47:45 INFO - 'cart']}, 01:47:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'talos_options': ['--disable-e10s'], 01:47:45 INFO - 'tests': ['tp5o']}, 01:47:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'tests': ['tp5o']}, 01:47:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'talos_options': ['--disable-e10s', 01:47:45 INFO - '--xperf_path', 01:47:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:45 INFO - 'tests': ['tp5n']}, 01:47:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:45 INFO - 'talos_options': ['--xperf_path', 01:47:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:45 INFO - 'tests': ['tp5n']}}, 01:47:45 INFO - 'talos.zip': {'path': '', 01:47:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:47:45 INFO - Running post-action listener: _resource_record_post_action 01:47:45 INFO - ##### 01:47:45 INFO - ##### Running create-virtualenv step. 01:47:45 INFO - ##### 01:47:45 INFO - Running pre-action listener: _resource_record_pre_action 01:47:45 INFO - Running main action method: create_virtualenv 01:47:45 INFO - Creating virtualenv /builds/slave/test/build/venv 01:47:45 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 01:47:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:47:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:47:45 INFO - Using real prefix '/usr' 01:47:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:47:46 INFO - Installing distribute.............................................................................................................................................................................................done. 01:47:48 INFO - Installing pip.................done. 01:47:48 INFO - Return code: 0 01:47:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:48 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 0x7f9df2538f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc410>, '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 0x1add310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1add7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:48 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 01:47:48 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 01:47:48 INFO - Using env: {'DISPLAY': ':0', 01:47:48 INFO - 'HOME': '/home/cltbld', 01:47:48 INFO - 'LANG': 'en_US.UTF-8', 01:47:48 INFO - 'LANGUAGE': 'en_US:en', 01:47:48 INFO - 'LOGNAME': 'cltbld', 01:47:48 INFO - 'MAIL': '/var/mail/cltbld', 01:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:48 INFO - 'MOZ_NO_REMOTE': '1', 01:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:48 INFO - 'NO_EM_RESTART': '1', 01:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:48 INFO - 'PWD': '/builds/slave/test', 01:47:48 INFO - 'SHELL': '/bin/bash', 01:47:48 INFO - 'SHLVL': '1', 01:47:48 INFO - 'TERM': 'linux', 01:47:48 INFO - 'TMOUT': '86400', 01:47:48 INFO - 'USER': 'cltbld', 01:47:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 01:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:48 INFO - '_': '/tools/buildbot/bin/python'} 01:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:48 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 01:47:48 INFO - Cleaning up... 01:47:48 INFO - Return code: 0 01:47:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:48 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 0x7f9df2538f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc410>, '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 0x1add310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1add7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:48 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 01:47:48 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 01:47:48 INFO - Using env: {'DISPLAY': ':0', 01:47:48 INFO - 'HOME': '/home/cltbld', 01:47:48 INFO - 'LANG': 'en_US.UTF-8', 01:47:48 INFO - 'LANGUAGE': 'en_US:en', 01:47:48 INFO - 'LOGNAME': 'cltbld', 01:47:48 INFO - 'MAIL': '/var/mail/cltbld', 01:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:48 INFO - 'MOZ_NO_REMOTE': '1', 01:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:48 INFO - 'NO_EM_RESTART': '1', 01:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:48 INFO - 'PWD': '/builds/slave/test', 01:47:48 INFO - 'SHELL': '/bin/bash', 01:47:48 INFO - 'SHLVL': '1', 01:47:48 INFO - 'TERM': 'linux', 01:47:48 INFO - 'TMOUT': '86400', 01:47:48 INFO - 'USER': 'cltbld', 01:47:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 01:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:48 INFO - '_': '/tools/buildbot/bin/python'} 01:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:48 INFO - Downloading/unpacking psutil>=0.7.1 01:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:47:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:47:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:47:50 INFO - Installing collected packages: psutil 01:47:50 INFO - Running setup.py install for psutil 01:47:50 INFO - building 'psutil._psutil_linux' extension 01:47:50 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 01:47:50 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 01:47:50 INFO - building 'psutil._psutil_posix' extension 01:47:50 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 01:47:50 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 01:47:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:47:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:47:51 INFO - Successfully installed psutil 01:47:51 INFO - Cleaning up... 01:47:51 INFO - Return code: 0 01:47:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9df2538f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc410>, '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 0x1add310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1add7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:47:51 INFO - Using env: {'DISPLAY': ':0', 01:47:51 INFO - 'HOME': '/home/cltbld', 01:47:51 INFO - 'LANG': 'en_US.UTF-8', 01:47:51 INFO - 'LANGUAGE': 'en_US:en', 01:47:51 INFO - 'LOGNAME': 'cltbld', 01:47:51 INFO - 'MAIL': '/var/mail/cltbld', 01:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:51 INFO - 'MOZ_NO_REMOTE': '1', 01:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:51 INFO - 'NO_EM_RESTART': '1', 01:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:51 INFO - 'PWD': '/builds/slave/test', 01:47:51 INFO - 'SHELL': '/bin/bash', 01:47:51 INFO - 'SHLVL': '1', 01:47:51 INFO - 'TERM': 'linux', 01:47:51 INFO - 'TMOUT': '86400', 01:47:51 INFO - 'USER': 'cltbld', 01:47:51 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 01:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:51 INFO - '_': '/tools/buildbot/bin/python'} 01:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:47:53 INFO - Installing collected packages: mozsystemmonitor 01:47:53 INFO - Running setup.py install for mozsystemmonitor 01:47:53 INFO - Successfully installed mozsystemmonitor 01:47:53 INFO - Cleaning up... 01:47:53 INFO - Return code: 0 01:47:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9df2538f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc410>, '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 0x1add310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1add7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:47:53 INFO - Using env: {'DISPLAY': ':0', 01:47:53 INFO - 'HOME': '/home/cltbld', 01:47:53 INFO - 'LANG': 'en_US.UTF-8', 01:47:53 INFO - 'LANGUAGE': 'en_US:en', 01:47:53 INFO - 'LOGNAME': 'cltbld', 01:47:53 INFO - 'MAIL': '/var/mail/cltbld', 01:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:53 INFO - 'MOZ_NO_REMOTE': '1', 01:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:53 INFO - 'NO_EM_RESTART': '1', 01:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:53 INFO - 'PWD': '/builds/slave/test', 01:47:53 INFO - 'SHELL': '/bin/bash', 01:47:53 INFO - 'SHLVL': '1', 01:47:53 INFO - 'TERM': 'linux', 01:47:53 INFO - 'TMOUT': '86400', 01:47:53 INFO - 'USER': 'cltbld', 01:47:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 01:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:53 INFO - '_': '/tools/buildbot/bin/python'} 01:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:53 INFO - Downloading/unpacking blobuploader==1.2.4 01:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:55 INFO - Downloading blobuploader-1.2.4.tar.gz 01:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:47:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:47:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:56 INFO - Downloading docopt-0.6.1.tar.gz 01:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:47:56 INFO - Installing collected packages: blobuploader, requests, docopt 01:47:56 INFO - Running setup.py install for blobuploader 01:47:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:47:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:47:56 INFO - Running setup.py install for requests 01:47:56 INFO - Running setup.py install for docopt 01:47:56 INFO - Successfully installed blobuploader requests docopt 01:47:56 INFO - Cleaning up... 01:47:56 INFO - Return code: 0 01:47:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:56 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 0x7f9df2538f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc410>, '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 0x1add310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1add7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:47:56 INFO - Using env: {'DISPLAY': ':0', 01:47:56 INFO - 'HOME': '/home/cltbld', 01:47:56 INFO - 'LANG': 'en_US.UTF-8', 01:47:56 INFO - 'LANGUAGE': 'en_US:en', 01:47:56 INFO - 'LOGNAME': 'cltbld', 01:47:56 INFO - 'MAIL': '/var/mail/cltbld', 01:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:56 INFO - 'MOZ_NO_REMOTE': '1', 01:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:56 INFO - 'NO_EM_RESTART': '1', 01:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:56 INFO - 'PWD': '/builds/slave/test', 01:47:56 INFO - 'SHELL': '/bin/bash', 01:47:56 INFO - 'SHLVL': '1', 01:47:56 INFO - 'TERM': 'linux', 01:47:56 INFO - 'TMOUT': '86400', 01:47:56 INFO - 'USER': 'cltbld', 01:47:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 01:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:56 INFO - '_': '/tools/buildbot/bin/python'} 01:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:47:57 INFO - Running setup.py (path:/tmp/pip-XpZoIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:47:57 INFO - Running setup.py (path:/tmp/pip-yIfspl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:47:57 INFO - Running setup.py (path:/tmp/pip-L9fQhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:47:57 INFO - Running setup.py (path:/tmp/pip-jEXsKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:47:57 INFO - Running setup.py (path:/tmp/pip-XBYevy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:47:57 INFO - Running setup.py (path:/tmp/pip-WG4Zas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:47:57 INFO - Running setup.py (path:/tmp/pip-ugFJOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:47:57 INFO - Running setup.py (path:/tmp/pip-kabAe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:47:57 INFO - Running setup.py (path:/tmp/pip-nsCKhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:47:57 INFO - Running setup.py (path:/tmp/pip-Aagvec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:47:57 INFO - Running setup.py (path:/tmp/pip-BWtUB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:47:57 INFO - Running setup.py (path:/tmp/pip-yh73nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:47:57 INFO - Running setup.py (path:/tmp/pip-6DmkJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:47:58 INFO - Running setup.py (path:/tmp/pip-3_nL8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:58 INFO - Running setup.py (path:/tmp/pip-HrW6_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:47:58 INFO - Running setup.py (path:/tmp/pip-ffplXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:47:58 INFO - Running setup.py (path:/tmp/pip-mJet5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:47:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:47:58 INFO - Running setup.py install for manifestparser 01:47:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:47:58 INFO - Running setup.py install for mozcrash 01:47:58 INFO - Running setup.py install for mozdebug 01:47:58 INFO - Running setup.py install for mozdevice 01:47:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:47:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:47:58 INFO - Running setup.py install for mozfile 01:47:58 INFO - Running setup.py install for mozhttpd 01:47:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:47:58 INFO - Running setup.py install for mozinfo 01:47:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Running setup.py install for mozInstall 01:47:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Running setup.py install for mozleak 01:47:59 INFO - Running setup.py install for mozlog 01:47:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Running setup.py install for moznetwork 01:47:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Running setup.py install for mozprocess 01:47:59 INFO - Running setup.py install for mozprofile 01:47:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Running setup.py install for mozrunner 01:47:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Running setup.py install for mozscreenshot 01:47:59 INFO - Running setup.py install for moztest 01:48:00 INFO - Running setup.py install for mozversion 01:48:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:48:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:48:00 INFO - Cleaning up... 01:48:00 INFO - Return code: 0 01:48:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:00 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 0x7f9df2538f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc410>, '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 0x1add310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1add7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:48:00 INFO - Using env: {'DISPLAY': ':0', 01:48:00 INFO - 'HOME': '/home/cltbld', 01:48:00 INFO - 'LANG': 'en_US.UTF-8', 01:48:00 INFO - 'LANGUAGE': 'en_US:en', 01:48:00 INFO - 'LOGNAME': 'cltbld', 01:48:00 INFO - 'MAIL': '/var/mail/cltbld', 01:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:00 INFO - 'MOZ_NO_REMOTE': '1', 01:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:00 INFO - 'NO_EM_RESTART': '1', 01:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:00 INFO - 'PWD': '/builds/slave/test', 01:48:00 INFO - 'SHELL': '/bin/bash', 01:48:00 INFO - 'SHLVL': '1', 01:48:00 INFO - 'TERM': 'linux', 01:48:00 INFO - 'TMOUT': '86400', 01:48:00 INFO - 'USER': 'cltbld', 01:48:00 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 01:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:00 INFO - '_': '/tools/buildbot/bin/python'} 01:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:00 INFO - Running setup.py (path:/tmp/pip-hpRlmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:00 INFO - Running setup.py (path:/tmp/pip-zR7NFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:00 INFO - Running setup.py (path:/tmp/pip-_sK7Bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:00 INFO - Running setup.py (path:/tmp/pip-ckxyV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:00 INFO - Running setup.py (path:/tmp/pip-buBQLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:00 INFO - Running setup.py (path:/tmp/pip-Ih3HTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:00 INFO - Running setup.py (path:/tmp/pip-Yk5jzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:00 INFO - Running setup.py (path:/tmp/pip-FpnTSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:00 INFO - Running setup.py (path:/tmp/pip-quqMhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:00 INFO - Running setup.py (path:/tmp/pip-Eil02F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:01 INFO - Running setup.py (path:/tmp/pip-02NnDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:01 INFO - Running setup.py (path:/tmp/pip-177Xg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:01 INFO - Running setup.py (path:/tmp/pip-fIDa4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:01 INFO - Running setup.py (path:/tmp/pip-d1ElhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:01 INFO - Running setup.py (path:/tmp/pip-DeN1de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:01 INFO - Running setup.py (path:/tmp/pip-zTYShQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:01 INFO - Running setup.py (path:/tmp/pip-I7BkBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:48:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:03 INFO - Downloading blessings-1.6.tar.gz 01:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:48:03 INFO - Installing collected packages: blessings 01:48:03 INFO - Running setup.py install for blessings 01:48:03 INFO - Successfully installed blessings 01:48:03 INFO - Cleaning up... 01:48:03 INFO - Return code: 0 01:48:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:48:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:03 INFO - Reading from file tmpfile_stdout 01:48:03 INFO - Current package versions: 01:48:03 INFO - argparse == 1.2.1 01:48:03 INFO - blessings == 1.6 01:48:03 INFO - blobuploader == 1.2.4 01:48:03 INFO - docopt == 0.6.1 01:48:03 INFO - manifestparser == 1.1 01:48:03 INFO - mozInstall == 1.12 01:48:03 INFO - mozcrash == 0.17 01:48:03 INFO - mozdebug == 0.1 01:48:03 INFO - mozdevice == 0.48 01:48:03 INFO - mozfile == 1.2 01:48:03 INFO - mozhttpd == 0.7 01:48:03 INFO - mozinfo == 0.9 01:48:03 INFO - mozleak == 0.1 01:48:03 INFO - mozlog == 3.1 01:48:03 INFO - moznetwork == 0.27 01:48:03 INFO - mozprocess == 0.22 01:48:03 INFO - mozprofile == 0.28 01:48:03 INFO - mozrunner == 6.11 01:48:03 INFO - mozscreenshot == 0.1 01:48:03 INFO - mozsystemmonitor == 0.0 01:48:03 INFO - moztest == 0.7 01:48:03 INFO - mozversion == 1.4 01:48:03 INFO - psutil == 3.1.1 01:48:03 INFO - requests == 1.2.3 01:48:03 INFO - wsgiref == 0.1.2 01:48:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:03 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 0x7f9df2538f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc410>, '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 0x1add310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1add7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:48:03 INFO - Using env: {'DISPLAY': ':0', 01:48:03 INFO - 'HOME': '/home/cltbld', 01:48:03 INFO - 'LANG': 'en_US.UTF-8', 01:48:03 INFO - 'LANGUAGE': 'en_US:en', 01:48:03 INFO - 'LOGNAME': 'cltbld', 01:48:03 INFO - 'MAIL': '/var/mail/cltbld', 01:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:03 INFO - 'MOZ_NO_REMOTE': '1', 01:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:03 INFO - 'NO_EM_RESTART': '1', 01:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:03 INFO - 'PWD': '/builds/slave/test', 01:48:03 INFO - 'SHELL': '/bin/bash', 01:48:03 INFO - 'SHLVL': '1', 01:48:03 INFO - 'TERM': 'linux', 01:48:03 INFO - 'TMOUT': '86400', 01:48:03 INFO - 'USER': 'cltbld', 01:48:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 01:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:03 INFO - '_': '/tools/buildbot/bin/python'} 01:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:48:04 INFO - Cleaning up... 01:48:04 INFO - Return code: 0 01:48:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:04 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 0x7f9df2538f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc410>, '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 0x1add310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1add7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:48:04 INFO - Using env: {'DISPLAY': ':0', 01:48:04 INFO - 'HOME': '/home/cltbld', 01:48:04 INFO - 'LANG': 'en_US.UTF-8', 01:48:04 INFO - 'LANGUAGE': 'en_US:en', 01:48:04 INFO - 'LOGNAME': 'cltbld', 01:48:04 INFO - 'MAIL': '/var/mail/cltbld', 01:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:04 INFO - 'MOZ_NO_REMOTE': '1', 01:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:04 INFO - 'NO_EM_RESTART': '1', 01:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:04 INFO - 'PWD': '/builds/slave/test', 01:48:04 INFO - 'SHELL': '/bin/bash', 01:48:04 INFO - 'SHLVL': '1', 01:48:04 INFO - 'TERM': 'linux', 01:48:04 INFO - 'TMOUT': '86400', 01:48:04 INFO - 'USER': 'cltbld', 01:48:04 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 01:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:04 INFO - '_': '/tools/buildbot/bin/python'} 01:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:04 INFO - Downloading/unpacking jsonschema 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:48:06 INFO - Downloading/unpacking functools32 (from jsonschema) 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:06 INFO - Downloading functools32-3.2.3-2.tar.gz 01:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:48:06 INFO - warning: no files found matching '*.txt' 01:48:06 INFO - no previously-included directories found matching 'build' 01:48:06 INFO - no previously-included directories found matching 'dist' 01:48:06 INFO - no previously-included directories found matching '.git*' 01:48:06 INFO - Installing collected packages: jsonschema, functools32 01:48:06 INFO - Running setup.py install for functools32 01:48:06 INFO - warning: no files found matching '*.txt' 01:48:06 INFO - no previously-included directories found matching 'build' 01:48:06 INFO - no previously-included directories found matching 'dist' 01:48:06 INFO - no previously-included directories found matching '.git*' 01:48:06 INFO - Successfully installed jsonschema functools32 01:48:06 INFO - Cleaning up... 01:48:06 INFO - Return code: 0 01:48:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:48: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')]} 01:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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')]} 01:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9df2538f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc410>, '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 0x1add310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1add7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:48: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', 'flake8'] in /builds/slave/test/build 01:48: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 flake8 01:48:06 INFO - Using env: {'DISPLAY': ':0', 01:48:06 INFO - 'HOME': '/home/cltbld', 01:48:06 INFO - 'LANG': 'en_US.UTF-8', 01:48:06 INFO - 'LANGUAGE': 'en_US:en', 01:48:06 INFO - 'LOGNAME': 'cltbld', 01:48:06 INFO - 'MAIL': '/var/mail/cltbld', 01:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:06 INFO - 'MOZ_NO_REMOTE': '1', 01:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:06 INFO - 'NO_EM_RESTART': '1', 01:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:06 INFO - 'PWD': '/builds/slave/test', 01:48:06 INFO - 'SHELL': '/bin/bash', 01:48:06 INFO - 'SHLVL': '1', 01:48:06 INFO - 'TERM': 'linux', 01:48:06 INFO - 'TMOUT': '86400', 01:48:06 INFO - 'USER': 'cltbld', 01:48:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 01:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:06 INFO - '_': '/tools/buildbot/bin/python'} 01:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:06 INFO - Downloading/unpacking flake8 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:48:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:48:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:48:09 INFO - no previously-included directories found matching 'docs/_build' 01:48:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:48:09 INFO - Running setup.py install for pep8 01:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:48:09 INFO - no previously-included directories found matching 'docs/_build' 01:48:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:48:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:48:09 INFO - Cleaning up... 01:48:09 INFO - Return code: 0 01:48:09 INFO - Running post-action listener: _resource_record_post_action 01:48:09 INFO - Running post-action listener: _start_resource_monitoring 01:48:09 INFO - Starting resource monitoring. 01:48:09 INFO - ##### 01:48:09 INFO - ##### Running install step. 01:48:09 INFO - ##### 01:48:09 INFO - Running pre-action listener: _resource_record_pre_action 01:48:09 INFO - Running main action method: install 01:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:10 INFO - Reading from file tmpfile_stdout 01:48:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:48:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:48:10 INFO - Reading from file tmpfile_stdout 01:48:10 INFO - Output received: 01:48:10 INFO - Usage: mozinstall [options] installer 01:48:10 INFO - Options: 01:48:10 INFO - -h, --help show this help message and exit 01:48:10 INFO - -d DEST, --destination=DEST 01:48:10 INFO - Directory to install application into. [default: 01:48:10 INFO - "/builds/slave/test"] 01:48:10 INFO - --app=APP Application being installed. [default: firefox] 01:48:10 INFO - mkdir: /builds/slave/test/build/application 01:48:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:48:25 INFO - Reading from file tmpfile_stdout 01:48:25 INFO - Output received: 01:48:25 INFO - /builds/slave/test/build/application/firefox/firefox 01:48:25 INFO - Running post-action listener: _resource_record_post_action 01:48:25 INFO - ##### 01:48:25 INFO - ##### Running run-tests step. 01:48:25 INFO - ##### 01:48:25 INFO - Running pre-action listener: _resource_record_pre_action 01:48:25 INFO - Running main action method: run_tests 01:48:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:48:25 INFO - Python 2.7.3 01:48:25 INFO - Return code: 0 01:48:25 INFO - grabbing minidump binary from tooltool 01:48: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')]} 01:48:25 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 0x1adc410>, '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 0x1add310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1add7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:48:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:48:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:48:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:48:25 INFO - Return code: 0 01:48:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:48:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:48:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:48:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:48:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:48:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:48:26 INFO - Return code: 0 01:48:26 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/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:48:26 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/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:48:26 INFO - Using env: {'DISPLAY': ':0', 01:48:26 INFO - 'HOME': '/home/cltbld', 01:48:26 INFO - 'LANG': 'en_US.UTF-8', 01:48:26 INFO - 'LANGUAGE': 'en_US:en', 01:48:26 INFO - 'LOGNAME': 'cltbld', 01:48:26 INFO - 'MAIL': '/var/mail/cltbld', 01:48:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:48:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:26 INFO - 'MOZ_NO_REMOTE': '1', 01:48:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:26 INFO - 'NO_EM_RESTART': '1', 01:48:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:26 INFO - 'PWD': '/builds/slave/test', 01:48:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:48:26 INFO - 'SHELL': '/bin/bash', 01:48:26 INFO - 'SHLVL': '1', 01:48:26 INFO - 'TERM': 'linux', 01:48:26 INFO - 'TMOUT': '86400', 01:48:26 INFO - 'USER': 'cltbld', 01:48:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088', 01:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:26 INFO - '_': '/tools/buildbot/bin/python'} 01:48:26 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/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:48:27 INFO - mozversion application_buildid: 20160430005741 01:48:27 INFO - mozversion application_changeset: aea9eee926979ec130fa3a1a32bdcede88b82a35 01:48:27 INFO - mozversion application_display_name: Nightly 01:48:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:48:27 INFO - mozversion application_name: Firefox 01:48:27 INFO - mozversion application_remotingname: firefox 01:48:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:48:27 INFO - mozversion application_vendor: Mozilla 01:48:27 INFO - mozversion application_version: 49.0a1 01:48:27 INFO - mozversion platform_buildid: 20160430005741 01:48:27 INFO - mozversion platform_changeset: aea9eee926979ec130fa3a1a32bdcede88b82a35 01:48:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:48:27 INFO - mozversion platform_version: 49.0a1 01:48:27 INFO - using testdate: 1462006107 01:48:27 INFO - actual date: 1462006107 01:48:27 INFO - starting webserver on 'localhost:44586' 01:48:27 INFO - SUITE-START | Running 2 tests 01:48:27 INFO - TEST-START | dromaeo_css 01:48:27 INFO - operating with platform_type : linux_ 01:48:27 INFO - Initialising browser for dromaeo_css test... 01:48:27 INFO - TEST-INFO | started process 13966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpryMVpA/profile http://localhost:44586/getInfo.html) 01:48:31 INFO - PROCESS | 13966 | __metrics Screen width/height:1600/1200 01:48:31 INFO - PROCESS | 13966 | colorDepth:24 01:48:31 INFO - PROCESS | 13966 | Browser inner width/height: 1024/697 01:48:31 INFO - PROCESS | 13966 | __metrics 01:48:32 ERROR - PROCESS | 13966 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:48:33 INFO - TEST-INFO | 13966: exit 0 01:48:33 INFO - Browser initialized. 01:48:33 INFO - Running cycle 1/1 for dromaeo_css test... 01:48:33 INFO - TEST-INFO | started process 14048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpryMVpA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:48:45 INFO - PROCESS | 14048 | RSS: Main: 156262400 01:48:45 INFO - PROCESS | 14048 | 01:49:36 INFO - PROCESS | 14048 | 1462006176719 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:51:48 INFO - PROCESS | 14048 | Cycle 1(1): loaded http://localhost:44586/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44586/tests/dromaeo/cssquery-ext.html) 01:51:49 INFO - PROCESS | 14048 | RSS: Main: 270184448 01:51:49 INFO - PROCESS | 14048 | 01:54:51 INFO - PROCESS | 14048 | Cycle 1(1): loaded http://localhost:44586/tests/dromaeo/cssquery-ext.html (next: http://localhost:44586/tests/dromaeo/cssquery-jquery.html) 01:54:52 INFO - PROCESS | 14048 | RSS: Main: 241221632 01:54:52 INFO - PROCESS | 14048 | 01:57:54 INFO - PROCESS | 14048 | Cycle 1(1): loaded http://localhost:44586/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44586/tests/dromaeo/cssquery-mootools.html) 01:57:55 INFO - PROCESS | 14048 | RSS: Main: 233742336 01:57:55 INFO - PROCESS | 14048 | 02:00:57 INFO - PROCESS | 14048 | Cycle 1(1): loaded http://localhost:44586/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44586/tests/dromaeo/cssquery-prototype.html) 02:00:58 INFO - PROCESS | 14048 | RSS: Main: 235020288 02:00:58 INFO - PROCESS | 14048 | 02:04:00 INFO - PROCESS | 14048 | Cycle 1(1): loaded http://localhost:44586/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44586/tests/dromaeo/cssquery-yui.html) 02:04:01 INFO - PROCESS | 14048 | RSS: Main: 214704128 02:04:01 INFO - PROCESS | 14048 | 02:07:04 INFO - PROCESS | 14048 | Cycle 1(1): loaded http://localhost:44586/tests/dromaeo/cssquery-yui.html (next: http://localhost:44586/tests/dromaeo/cssquery-dojo.html) 02:07:04 INFO - PROCESS | 14048 | RSS: Main: 271982592 02:07:04 INFO - PROCESS | 14048 | 02:07:04 INFO - PROCESS | 14048 | __start_tp_report 02:07:04 INFO - PROCESS | 14048 | _x_x_mozilla_page_load 02:07:04 INFO - PROCESS | 14048 | _x_x_mozilla_page_load_details 02:07:04 INFO - PROCESS | 14048 | |i|pagename|runs| 02:07:04 INFO - PROCESS | 14048 | |0;dojo.html;2548.9617655735165;2596.052440859087;2623.435961268327;2632.921012369629;2637.1165659504063;4563.771811409424;4595.058013107313;4600.907981840365;4618.44578650562;4637.211674015417;4577.176108300505;4620.537946205378;4641.164590373732;4697.037107392985;4731.408573928259;4216.430781844442;4219.177260434217;4255.936160957588;4277.55085716;4350.847720329789;4309.095090031082;4325.437693099892;4334.45819272591;4373.781310934456;4379.627731642814;4152.875413737593;4179.331306990867;4239.982404222964;4253.851115210953;4256.084941737541;4204.936925946114;4241.745495270263;4246.426732391118;4285.721428107194;4300.204462174508;4130.070734084837;4240.406343111967;4251.319788833803;4256.553061928515;4286.485621725382;4441.977790111029;4538.160440318552;4579.7252164870215;4581.106684196583;4634.907301853944;4886.389201349832;4908.116539022974;4908.214685650314;4911.778969946361;4946.72792996385;4898.779554920037;4916.459189489154;4916.50834916509;4972.602191824645;4980.975095124538;4569.95430045702;4608.654350923694;4633.62930965522;4722.008378240539;4722.079194557097;5044.722540260321;5053.065182941167;5058.468860769566;5069.822556210589;5072.797088116507;4877.12211801879;4882.902341953141;4895.192293271642;4895.314655948099;4929.679570827885;4811.158047341702;4895.853124406273;4967.875803104951;4975.800967961313;4983.302337672729;4908.6073114151495;4908.828191013297;4918.360613120271;4921.655484116149;4964.702117872939;4886.804527818918;4896.975515122402;4909.386326709161;4913.48408417111;4944.159492886218;4162;4178.561251068594;4232.280512312853;4257.893552661147;4264.530901600821;3674.8530058797883;3683.079230192452;3690.686291665185;3710.18375957289;3717.237966216919;4262.339337402707;4263.275243208662;4266.637335826427;4299.247631664446;4313.029568347097;4889.975550122298;4914.950850491449;4918.852434426973;4971.552560269593;5011.173156429149;4301.913961720748;4309.224339618899;4327.588879056485;4338.544452832471;4373.343998400265;4502.954970450319;4529.497685242505;4533.591976722111;4539.7049191802425;4571.291449825282;4568.291914753285;4605.746683932416;4668.369770080995;4674.7896344663895;4724.2205036169335;4938.925916111333;4985.277134815359;4996.500349964975;4998.6750861193905;5048.040872234411;4673.579377856009;4683.976580117078;4695.765211739331;4701.600363968964;4746.762661866824;4783.784729687242;4809.879753006203;4858.7570621469495;4887.853364399074;4896.387951506062;4947.82682606107;4957.03337849116;4978.4025916890205;5004.649674522894;5023.547880690755;4716.33971244033;4850.175470170009;4863.416390033219;4866.318715379921;4917.729524876167;4737.644676649334;4782.665213435165;4788.473267940454;4828.227483602606;4829.13075646387;4748.762561871962;4794.808207671794;4796.592289655278;4805.063012712488;4850.175470170009;4748.31149483316;4831.396075490564;4886.193778026728;4912.410510738734;4962.181240095344;4771.785269662943;4772.928406073981;4786.401699787527;4833.637477189154;4836.347093142381 02:07:04 INFO - PROCESS | 14048 | |1;ext.html;551.618913486789;583.932847722512;587.5740088435884;604.9999999999999;619.3868070610092;33024.5046324305;33865;34367.82816085922;34421;34422.65577344226;36497.27005459896;37310.44034339487;37363;37441;37446.43830342547;7293.197748247689;7344.669489872956;7598;9501.42991420517;9722.805543889119;9675.951620241889;9863.802723945517;9865.506724663774;9870.901290987105;9878.60485580576;10026.69919902404;10226.130778883804;10230.335028223179;10237.692869213935;10239.744006399862;10017.298789084767;10118.747031324203;10135;10147.492625368775;10154.086132248132;9985.05142011515;10119;10130.493475326204;10136.847947280796;10136.847947280796;37019.25961480782;37590;37677;37717.811410943046;37725.811370943244;3089.845507724605;3136.592243008417;3208.8395580220895;3433.8111403872776;3739.869104581354;28936.276593085342;29134;29378.265543361587;29880.25299367533;30275;3469.2194256292387;3488.180277634754;3490.738194635387;3537.6285490023433;3573.76770509916;250158;252426;253031;253090;253641;46365.5363446368;46988;46989.5301046992;47016;47122.29316560255;55576.16635750467;55854.72072639611;55883;55891.44108558862;55984;14740.336684849208;15291.158986255863;15301.846981530265;15308.846911530742;15309.923450382677;11762.235454695418;11851.525938962517;11889.762204755856;11889.821652675217;11893.34586597728;15646.295916683777;15735.68528629421;15795.36818527269;15805.604859878595;15859.841401585836;5850.765969361178;5851.297844258716;5956.374580669054;5958.374370691102;6014.188084608521;839.4585492357395;889.8042430665244;908.3550679017972;955.254901177083;996.1930836022844;27773.166804995883;28061.719382806317;28104.156875293775;28415.71584284172;28804.42391152207;989.4557993103764;1022.3405903192399;1094.370736826328;1106.3693694594165;1127.4081107418506;14608.707825843423;15045.548633541011;15170.924145379202;15210.183333914994;15367.077975321516;329709;330536;334114;334509;335132;50169.74915125401;50413.74793126084;50558;50570;50586.241206381936;1094.5129417409175;1197.126097948485;1201.6335017819474;1250.881166289201;1294.9093563450656;27586.172414827586;28919;29125.41749165047;29480;29638.40723185481;39640.40539391969;40458;40459.39310910398;40487;41126.38310425286;268183;268280;270205;270815.9806416398;271435;20486;22959.88520057389;23160.536789263784;23350.76649233486;24712.13507527228;36797.81601091977;36930.44604330991;37421.43867842039;37574.81212594029;37745.245095097394;31541.842290788398;32068;34042.31915361728;34819.30361392809;35256.29487410289;34264;34742;34829.825850870584;35044.474332884514;35271.11822204466;32314.676853231165;34317.65682343145;34513.13717157091;34742.305153896275;34778.30443391067;27280.181594552196;27646.861765691043;28822.855885720437;29963.400731984802;31813.363732724752;24265.029398824554;24364.390890227885;24553.263402097964;25002.874985625684;25107.87446062758 02:07:04 INFO - PROCESS | 14048 | |2;jquery.html;374.5262243262272;376.6628867163888;383.18573032306347;384.7633705271259;391.82367934429516;15591.298391572378;16357.427490037837;17174.39889603864;17192.054437005958;17193.398231061914;15725.685486290267;16233.188340582983;16452.341906323734;16470.258838352274;16475.2586133624;4586.610138138254;4860.05228980349;4876.707397556141;4880.341153944225;4881.853544393656;3527.2416430467442;3727.90680232995;5406.648567843077;5707.3721890592005;5709.4290570942785;5671.461211184951;5674.829755107333;5678.659280443187;5684.374718780951;5698.772049118031;5301.7084060376665;5599.1041433370465;5599.468050535193;5604.41153678864;5610.69141197234;3458.602260740022;5178.456262092502;5462;5469.316335458067;5470.17947307903;12181;12264;12310.13829031968;12314.5074197032;12422.565210217599;1908.0624798871286;1996.0019990004998;2185.7377114746173;2301.735300440437;2448.1553863917097;9066.184043436122;9348.345615806897;9573.952130239373;10228;12821.423035963404;1726.965460690779;1746.956326091845;1782.643471305731;1842.3551756885117;1845.3541260558832;66460.33539664638;71028.28971710269;72362.27637723608;73338;73868.26131738721;9980.700578982642;10009.399436033862;10059.849102263472;10132.645357412455;10243.539040743184;14038.929805350908;14140.717185656229;14141.575752727435;14147.43410263578;14180.361883715257;7302.087239095114;7319.817004574928;7329.267073292628;7375.971607807788;7513.436492263102;6748.966255168692;6762.763303284361;6775.525713200127;6867.07294515244;6872.828179295458;4057.472528571267;4098.7950602469755;4104.4048612950955;4116.0533077391765;4186.434831297796;1712.8458438740572;1769.2834402067183;1788.2399980008445;1804.7202683584067;1838.4025191812714;792.3859009267863;826.574314228173;861.2076889261895;886.6453418632469;943.2689665509148;15431.61420964485;16476;16480.67038659244;16649.50051498457;17021;822.4859462835727;847.1147650705028;855.4482358878613;859.1837754133599;927.7355953553205;9037.548122593844;9171.44971301724;9326.487043212554;9661;9678.903210967801;388306;395419;401932;402585;404416;68572;75954.6202268985;79113.60443197747;79192.60403697945;80589.59705201436;839.9496030238205;919.5080631861922;934.6541779541477;971.223021582731;979.7354714227118;14197.083393741712;14723.631909202355;14937.701245975237;15042.473513426978;15817.525474235792;32633.836830815693;32731.018069457954;33684.99999999902;34235.65764342325;36122.27755444929;42299.7885010573;44589.33116003198;47460.288095677904;48376.758116209196;48614;7401.777946661608;7605;7683.0780306363595;7692.115406728298;7721.729739459317;6837.965810170917;9224.446533208029;11083.682301088302;11345.489452974802;11390.943045284721;9115.726528204164;9140.268778497571;9292.16370526656;9340.34617576763;9376;8992.415492992934;9892.505374731378;9963.153131983572;9983;10048.849267261143;9092.272618190662;9169.449833010041;9400.670976515788;9493.28800339991;9705.466199359103;7178.102737157856;7218.133823941161;7368.115826100902;7397.926020739724;7464.253574642492;7674.731384401519;8680.088590697886;8941.418807777474;9128.361014728906;9202.769930751518 02:07:04 INFO - PROCESS | 14048 | |3;mootools.html;1231.5012419969914;1438.690681503477;1471.4849802569101;1585.6353038801076;1754.9034803085826;6671.733130674773;7466.589337586437;7679.116901556323;7688.769336919901;7708.344790692798;7493.175750667422;7644.847103057936;7647.61761911905;7648.388128949685;7658.578778167199;1897.5635603811131;1970.9901450492728;1973.8124878136625;2145.1097794415336;2182.6507758758603;1971.4085774267662;2174.7825217478285;2254.3800454874877;2257.559775843703;2258.0516183203094;2135.903884325209;2157.094020511381;2163.978360216401;2165.1988764157286;2165.8267338612873;1824.188236234876;2127.8084972352485;2130.499332656824;2130.6164890319737;2138.0592539282743;2114.640511113099;2186.5954798362354;2189.4416923684516;2190.244365693833;2192.024549075662;7402.555846649218;7441.479096463249;7449.068866391701;7451.068616422947;7456.030716006884;4403.207422663919;4557.931631025537;4564.954350456486;4572.679912406133;4584.060267645124;2746.3134216445887;2836.4327134572964;2961.718636729507;2991.3568582754597;2993.625796775403;884.2572239318939;935.0742764662934;950.334765664031;1689.2820551265786;1742.6427582345589;10181.185505159643;10242;10253.23100767438;10258.230632702576;10273.486325683685;3996.5603783583783;4081.285774989365;4147.854825081168;4183.5398106208295;4183.769892655872;8197.34421246299;8202.343812494986;8210.548419836847;8230.958845205736;8243.299319557786;4603.654725895572;4666.906661866744;4667.649926255544;4692.601128904082;4698.694584851974;3713;3824.579296277407;4238.703290769617;4337.566243375637;4370.060437006059;3370.612379576331;3455.222574920673;3478.9652103479148;3485.634008429129;3490.5636795400574;1020.4948550467566;1063.5426766490484;1063.984040239397;1067.4716015572342;1071.8017166824006;877.3288434347729;879.5821984557284;894.6466145872344;902.5848109869534;910.717677519971;5425.511703946664;5462.9726851365485;5475.7262136893;5558.749856256478;5609.943900561024;407.2974119643591;409.68863663615866;415.8295099009392;419.5447938986234;421.0463300624089;3738.6448287412654;3745.962540374616;3779.7543159694533;3818.866339678098;3862.2661694278;9362.765930851783;9794.167495762798;9826.606935722633;9925.255605829447;9936.354136981074;9533.094356036165;9713.36863103896;9790.804183916282;9830.459324737065;9847.901520984842;7361.153467351323;7380.520266182681;7438.070241219848;7465.440091993122;7498.437617178624;5354.919676204938;5442.727863606883;5493.725313734218;5568.805091821767;5602.047651899105;8601.483910965362;9011.729648110568;9074.364794464323;9135.223506002065;9154.908450915405;8848.46909185451;9096.499692516974;9153.359264851397;9240.214581760625;9284.535773211448;5490.670559766427;5739.311282646109;5740.311162660508;6317.084022816574;6414.775482858077;6731.922892337203;7449.106107267163;7538.208488108669;7549.3583045439555;7587.62061896914;6596.5052621052655;6651.301613330531;6778.796636100925;6811.8978215325815;6901.827454313682;6663.502136058239;6692.732290708512;6703.396694297341;6743.797686069426;6753.2909044549615;6188.8762224754355;6229.688515574113;6254.749810007549;6256.812295631138;6260.874782504416;4606.700564463299;4661.230896902109;4761.666683332133;4862.41651001882;4871.391076115486;4714.882127946692;4759.476457589732;4759.9286010709175;4833.347498087714;4835.129676658235 02:07:04 INFO - PROCESS | 14048 | |4;prototype.html;306.36429408976363;306.97237248647616;309.78934324659224;312.49220017471623;312.7748021424574;4729.692569982953;4794.1130890785225;4800.159972004903;4814.229723244282;4836.516348365161;4765.070811191819;4769.761511924407;4777.593904518111;4778.71327720337;4784.736839473836;3805.1058001369656;3807.999999999993;3811.8284677189454;3814.5231846019246;3835.5972622874615;3689.465027571014;3806.371948628473;3820.1595648957186;3820.3505404081234;3821.7515861469055;3688.612695666943;3736.9813150934206;3768.773873567581;3783.81080945953;3801.467794508771;3724.832382542792;3734.7012239020814;3743.2326373093724;3758.699304055669;3765.9246815063684;3137.2784259620416;3205.1506350817053;3319.203391186122;3346.0631023313513;3365.209175843675;4556.248219043854;4557.726536407793;4559.52125026874;4574.908501829945;4585.72485650862;4258.701890867641;4272.2950713132295;4282.764447955361;4289.463817022872;4301.139772045603;4716.952830471686;4742.454617718972;4923.153817318505;4971.875703107415;4988.825391111293;3642.817859107034;3657.579378371495;3663.9267214655556;3664.5236119304586;3668.4497325401135;5189.636725429222;5197.8960420791755;5206.843794686166;5215.452377500384;5224.216367544861;3523.2342611050203;3655.3420384331075;3670.559532856021;3676.209614932802;3767.868124615625;3665.450182472597;3677.5770786359376;3689.815509224528;3727.6272372762505;3728.8694895678523;4190.350495673176;4202.159568086395;4212.157568486254;4231.286329036745;4238.1099969006855;4788.449328327218;5022.271770593316;5030.378127748016;5039.748012599355;5046.949530504721;1354.6681063139595;1355.4103964775354;1357.7915655066997;1358.5380970470087;1364.8293963254594;851.5444237332997;860.6643409070467;863.7322430046705;872.4721543466238;880.221004411088;4723.551262630044;4723.913499895043;4737.407824021997;4746.952530474651;4749.4063242094735;5546.55627549795;5552.444755524496;5560.277163968658;5560.888782224333;5568.911658128202;4660.39414876064;4688.5304874392705;4749;4766.832126129051;4773.427188737373;2770.7090755470385;2853.629028226317;2941.5881776550873;2964.6294213223346;2965.599644048069;5224.92162617561;5227;5234.607404444682;5239.842804715865;5240.659357141773;5661.264035675335;5667.3482549507335;5671.546276297886;5690.9146362804595;5699.373068962411;4975.825846095369;5183.3261675981885;5216.791328346823;5234.97382513085;5240.161574148118;5515.338159420895;5531.419200984;5531.585131115263;5548.112302031817;5566.109422492382;4863.659543831898;5424.945750542444;5442.727863606883;5458.344998600034;5472.398036216093;4895.314655948099;4896.902061958812;4898.142825005539;4930.038642464685;4949.183384741477;3621.1713084893013;3624.2389098289655;3634.3639863024396;3651.9817400912825;3657.085728567858;5029.0947629427055;5170.922436163536;5190.6107041972755;5195.402528709095;5210.687358758487;5050.247615049881;5053.469385714447;5054.974725126351;5068.29043933857;5071.949280507148;5027.4218464877;5055.570276526537;5066.82266120684;5070.290159377764;5074.873128171826;4780.378550788375;4929.309896614549;4965.627577931597;4967.4535801062575;4970.875728106682;5058.671186372874;5077.019962214666;5077.258280528473;5086.542211200862;5116.74416279192;4959.231319145538;4959.925601115914;4965.751712414437;4968.205087186033;4993.775280112476 02:07:04 INFO - PROCESS | 14048 | |5;yui.html;644.2912795924483;691.7025678958049;742.9888551671726;764.9471869364464;793.4763056382785;11959.162858599902;12025.037996960244;12171.14801963863;12196;12256.26462412256;11243.494042768074;11542.884571154285;11543.422828858565;11554.653360399201;11932.224405413664;628.940250676185;776.809681628002;790.7271991163054;796.2475460689651;805.472415567804;800.3557136505111;803.2931020701774;803.8311954489565;804.3565147881701;804.9114597394282;840.6805413942693;844.5734903873536;844.6072576252042;844.8056946902216;844.995775021124;646.844757258257;805.4563169860321;829.7386323308169;830.4643504939311;835.9205875441824;610.6824451285352;611.0894766797484;611.1596554737237;611.1901730207493;611.2512172588588;12518.436670349856;12541.435635396429;12557.372131393486;12588.181768185039;12589.433475493624;11527.827082593767;12218.20581662189;12678.112532122756;12896.290704011275;12930.870691293061;9396.62413503459;9506.08091337801;9799.90200097997;9856.852147217798;9959.601615935353;3168.889088881901;3274.4269752793402;3290.851911663981;3292.193412613901;3301.5377847101427;43070.353944690854;43307;43601.78199108984;43649.78175109104;43713.56286437158;8838.602262898185;8885.555722213992;9219.262459003263;9265.397749146285;9313.90686093144;16099.919500402422;16232.513024609281;16276.593085172966;16299.837001629832;16381.426650067191;6366.26787919386;6476.579022363531;6481.578697384655;6539.771108011197;6634.568753031134;3449.0859922120158;3541.203229273393;3551.5027896094566;3645.4714066460215;3669.541307336583;2867.971320286812;2907.956380654292;2923.342247994184;2926.824390536575;2929.3262549613282;506.2431664661281;506.98225562105887;510.39008384979593;514.4906542522875;521.3535216331798;420.4849059901657;536.8255317021983;541.3584901891271;545.9972700136474;592.4904582059512;6768.796936091827;7022.789316320519;7076.221615622278;7134.143902731602;7187.748428804966;407.7105255268792;480.2268347959782;571.8141603978723;580.4775701868352;584.2288179602969;3357;3386.153461634591;3416.1801167720064;3461.6019157797177;3476.617572067071;47802.28296575554;47937.760311198916;48404;48634;49324.75337623361;45746.31380529295;46082.53917460849;46652.833679157615;46697.53302466932;47009.29907009272;42310.36534451986;42461.78769106135;42508.14983700309;42787;43495.130097398505;6958.43233946083;7344.779656610311;7381.1432754509215;7428.6285685716575;7486.962565187139;28759.281017974718;29067;29299;29534.11397658074;29975.700242997293;36226.8188659055;37851.62148378481;37889.43165852459;38052.809735951145;38180.6181938177;9391.107844754737;9474.194693450858;9515.952420237854;9554.092361225672;9651.517424128906;10295.485225738832;10597.2581919268;10716.249862509861;10754;10998.560057597606;9573.856392153984;9679.322447428613;9789.216862650828;9869.555869986012;9883.209343252378;9932.801343973224;9958.50207489637;10027.298089133983;10070.345427547187;10171.84742228882;9341.11259430353;9383.436993780122;9617.807643847224;9663.855042174513;9957.153641940517;8603;8702.521361325187;8819;8867;9174.541272936192;8495.787605309917;8587.484750914966;8736.956315218638;8740.912590874264;8809.11908809114 02:07:04 INFO - PROCESS | 14048 | __end_tp_report 02:07:04 INFO - PROCESS | 14048 | __start_cc_report 02:07:04 INFO - PROCESS | 14048 | _x_x_mozilla_cycle_collect,1034 02:07:04 INFO - PROCESS | 14048 | __end_cc_report 02:07:04 INFO - PROCESS | 14048 | __startTimestamp1462007224422__endTimestamp 02:07:04 INFO - PROCESS | 14048 | 02:07:04 INFO - PROCESS | 14048 | ------- Summary: start ------- 02:07:04 INFO - PROCESS | 14048 | Number of tests: 6 02:07:04 INFO - PROCESS | 14048 | 02:07:04 INFO - PROCESS | 14048 | [#0] dojo.html Cycles:165 Average:4582.67 Median:4722.08 stddev:471.76 (10.0%) stddev-sans-first:445.41 02:07:04 INFO - PROCESS | 14048 | Values: 2549.0 2596.1 2623.4 2632.9 2637.1 4563.8 4595.1 4600.9 4618.4 4637.2 4577.2 4620.5 4641.2 4697.0 4731.4 4216.4 4219.2 4255.9 4277.6 4350.8 4309.1 4325.4 4334.5 4373.8 4379.6 4152.9 4179.3 4240.0 4253.9 4256.1 4204.9 4241.7 4246.4 4285.7 4300.2 4130.1 4240.4 4251.3 4256.6 4286.5 4442.0 4538.2 4579.7 4581.1 4634.9 4886.4 4908.1 4908.2 4911.8 4946.7 4898.8 4916.5 4916.5 4972.6 4981.0 4570.0 4608.7 4633.6 4722.0 4722.1 5044.7 5053.1 5058.5 5069.8 5072.8 4877.1 4882.9 4895.2 4895.3 4929.7 4811.2 4895.9 4967.9 4975.8 4983.3 4908.6 4908.8 4918.4 4921.7 4964.7 4886.8 4897.0 4909.4 4913.5 4944.2 4162.0 4178.6 4232.3 4257.9 4264.5 3674.9 3683.1 3690.7 3710.2 3717.2 4262.3 4263.3 4266.6 4299.2 4313.0 4890.0 4915.0 4918.9 4971.6 5011.2 4301.9 4309.2 4327.6 4338.5 4373.3 4503.0 4529.5 4533.6 4539.7 4571.3 4568.3 4605.7 4668.4 4674.8 4724.2 4938.9 4985.3 4996.5 4998.7 5048.0 4673.6 4684.0 4695.8 4701.6 4746.8 4783.8 4809.9 4858.8 4887.9 4896.4 4947.8 4957.0 4978.4 5004.6 5023.5 4716.3 4850.2 4863.4 4866.3 4917.7 4737.6 4782.7 4788.5 4828.2 4829.1 4748.8 4794.8 4796.6 4805.1 4850.2 4748.3 4831.4 4886.2 4912.4 4962.2 4771.8 4772.9 4786.4 4833.6 4836.3 02:07:04 INFO - PROCESS | 14048 | 02:07:04 INFO - PROCESS | 14048 | [#1] ext.html Cycles:180 Average:43989.81 Median:181780.25 stddev:75088.57 (41.3%) stddev-sans-first:75228.38 02:07:04 INFO - PROCESS | 14048 | Values: 551.6 583.9 587.6 605.0 619.4 33024.5 33865.0 34367.8 34421.0 34422.7 36497.3 37310.4 37363.0 37441.0 37446.4 7293.2 7344.7 7598.0 9501.4 9722.8 9676.0 9863.8 9865.5 9870.9 9878.6 10026.7 10226.1 10230.3 10237.7 10239.7 10017.3 10118.7 10135.0 10147.5 10154.1 9985.1 10119.0 10130.5 10136.8 10136.8 37019.3 37590.0 37677.0 37717.8 37725.8 3089.8 3136.6 3208.8 3433.8 3739.9 28936.3 29134.0 29378.3 29880.3 30275.0 3469.2 3488.2 3490.7 3537.6 3573.8 250158.0 252426.0 253031.0 253090.0 253641.0 46365.5 46988.0 46989.5 47016.0 47122.3 55576.2 55854.7 55883.0 55891.4 55984.0 14740.3 15291.2 15301.8 15308.8 15309.9 11762.2 11851.5 11889.8 11889.8 11893.3 15646.3 15735.7 15795.4 15805.6 15859.8 5850.8 5851.3 5956.4 5958.4 6014.2 839.5 889.8 908.4 955.3 996.2 27773.2 28061.7 28104.2 28415.7 28804.4 989.5 1022.3 1094.4 1106.4 1127.4 14608.7 15045.5 15170.9 15210.2 15367.1 329709.0 330536.0 334114.0 334509.0 335132.0 50169.7 50413.7 50558.0 50570.0 50586.2 1094.5 1197.1 1201.6 1250.9 1294.9 27586.2 28919.0 29125.4 29480.0 29638.4 39640.4 40458.0 40459.4 40487.0 41126.4 268183.0 268280.0 270205.0 270816.0 271435.0 20486.0 22959.9 23160.5 23350.8 24712.1 36797.8 36930.4 37421.4 37574.8 37745.2 31541.8 32068.0 34042.3 34819.3 35256.3 34264.0 34742.0 34829.8 35044.5 35271.1 32314.7 34317.7 34513.1 34742.3 34778.3 27280.2 27646.9 28822.9 29963.4 31813.4 24265.0 24364.4 24553.3 25002.9 25107.9 02:07:04 INFO - PROCESS | 14048 | 02:07:04 INFO - PROCESS | 14048 | [#2] jquery.html Cycles:180 Average:23949.37 Median:5434.32 stddev:65805.66 (1210.9%) stddev-sans-first:65966.45 02:07:04 INFO - PROCESS | 14048 | Values: 374.5 376.7 383.2 384.8 391.8 15591.3 16357.4 17174.4 17192.1 17193.4 15725.7 16233.2 16452.3 16470.3 16475.3 4586.6 4860.1 4876.7 4880.3 4881.9 3527.2 3727.9 5406.6 5707.4 5709.4 5671.5 5674.8 5678.7 5684.4 5698.8 5301.7 5599.1 5599.5 5604.4 5610.7 3458.6 5178.5 5462.0 5469.3 5470.2 12181.0 12264.0 12310.1 12314.5 12422.6 1908.1 1996.0 2185.7 2301.7 2448.2 9066.2 9348.3 9574.0 10228.0 12821.4 1727.0 1747.0 1782.6 1842.4 1845.4 66460.3 71028.3 72362.3 73338.0 73868.3 9980.7 10009.4 10059.8 10132.6 10243.5 14038.9 14140.7 14141.6 14147.4 14180.4 7302.1 7319.8 7329.3 7376.0 7513.4 6749.0 6762.8 6775.5 6867.1 6872.8 4057.5 4098.8 4104.4 4116.1 4186.4 1712.8 1769.3 1788.2 1804.7 1838.4 792.4 826.6 861.2 886.6 943.3 15431.6 16476.0 16480.7 16649.5 17021.0 822.5 847.1 855.4 859.2 927.7 9037.5 9171.4 9326.5 9661.0 9678.9 388306.0 395419.0 401932.0 402585.0 404416.0 68572.0 75954.6 79113.6 79192.6 80589.6 839.9 919.5 934.7 971.2 979.7 14197.1 14723.6 14937.7 15042.5 15817.5 32633.8 32731.0 33685.0 34235.7 36122.3 42299.8 44589.3 47460.3 48376.8 48614.0 7401.8 7605.0 7683.1 7692.1 7721.7 6838.0 9224.4 11083.7 11345.5 11390.9 9115.7 9140.3 9292.2 9340.3 9376.0 8992.4 9892.5 9963.2 9983.0 10048.8 9092.3 9169.4 9400.7 9493.3 9705.5 7178.1 7218.1 7368.1 7397.9 7464.3 7674.7 8680.1 8941.4 9128.4 9202.8 02:07:04 INFO - PROCESS | 14048 | 02:07:04 INFO - PROCESS | 14048 | [#3] mootools.html Cycles:180 Average:5079.25 Median:4866.90 stddev:2833.29 (58.2%) stddev-sans-first:2826.48 02:07:04 INFO - PROCESS | 14048 | Values: 1231.5 1438.7 1471.5 1585.6 1754.9 6671.7 7466.6 7679.1 7688.8 7708.3 7493.2 7644.8 7647.6 7648.4 7658.6 1897.6 1971.0 1973.8 2145.1 2182.7 1971.4 2174.8 2254.4 2257.6 2258.1 2135.9 2157.1 2164.0 2165.2 2165.8 1824.2 2127.8 2130.5 2130.6 2138.1 2114.6 2186.6 2189.4 2190.2 2192.0 7402.6 7441.5 7449.1 7451.1 7456.0 4403.2 4557.9 4565.0 4572.7 4584.1 2746.3 2836.4 2961.7 2991.4 2993.6 884.3 935.1 950.3 1689.3 1742.6 10181.2 10242.0 10253.2 10258.2 10273.5 3996.6 4081.3 4147.9 4183.5 4183.8 8197.3 8202.3 8210.5 8231.0 8243.3 4603.7 4666.9 4667.6 4692.6 4698.7 3713.0 3824.6 4238.7 4337.6 4370.1 3370.6 3455.2 3479.0 3485.6 3490.6 1020.5 1063.5 1064.0 1067.5 1071.8 877.3 879.6 894.6 902.6 910.7 5425.5 5463.0 5475.7 5558.7 5609.9 407.3 409.7 415.8 419.5 421.0 3738.6 3746.0 3779.8 3818.9 3862.3 9362.8 9794.2 9826.6 9925.3 9936.4 9533.1 9713.4 9790.8 9830.5 9847.9 7361.2 7380.5 7438.1 7465.4 7498.4 5354.9 5442.7 5493.7 5568.8 5602.0 8601.5 9011.7 9074.4 9135.2 9154.9 8848.5 9096.5 9153.4 9240.2 9284.5 5490.7 5739.3 5740.3 6317.1 6414.8 6731.9 7449.1 7538.2 7549.4 7587.6 6596.5 6651.3 6778.8 6811.9 6901.8 6663.5 6692.7 6703.4 6743.8 6753.3 6188.9 6229.7 6254.7 6256.8 6260.9 4606.7 4661.2 4761.7 4862.4 4871.4 4714.9 4759.5 4759.9 4833.3 4835.1 02:07:04 INFO - PROCESS | 14048 | 02:07:04 INFO - PROCESS | 14048 | [#4] prototype.html Cycles:180 Average:4258.46 Median:4778.15 stddev:1252.24 (26.2%) stddev-sans-first:1220.11 02:07:04 INFO - PROCESS | 14048 | Values: 306.4 307.0 309.8 312.5 312.8 4729.7 4794.1 4800.2 4814.2 4836.5 4765.1 4769.8 4777.6 4778.7 4784.7 3805.1 3808.0 3811.8 3814.5 3835.6 3689.5 3806.4 3820.2 3820.4 3821.8 3688.6 3737.0 3768.8 3783.8 3801.5 3724.8 3734.7 3743.2 3758.7 3765.9 3137.3 3205.2 3319.2 3346.1 3365.2 4556.2 4557.7 4559.5 4574.9 4585.7 4258.7 4272.3 4282.8 4289.5 4301.1 4717.0 4742.5 4923.2 4971.9 4988.8 3642.8 3657.6 3663.9 3664.5 3668.4 5189.6 5197.9 5206.8 5215.5 5224.2 3523.2 3655.3 3670.6 3676.2 3767.9 3665.5 3677.6 3689.8 3727.6 3728.9 4190.4 4202.2 4212.2 4231.3 4238.1 4788.4 5022.3 5030.4 5039.7 5046.9 1354.7 1355.4 1357.8 1358.5 1364.8 851.5 860.7 863.7 872.5 880.2 4723.6 4723.9 4737.4 4747.0 4749.4 5546.6 5552.4 5560.3 5560.9 5568.9 4660.4 4688.5 4749.0 4766.8 4773.4 2770.7 2853.6 2941.6 2964.6 2965.6 5224.9 5227.0 5234.6 5239.8 5240.7 5661.3 5667.3 5671.5 5690.9 5699.4 4975.8 5183.3 5216.8 5235.0 5240.2 5515.3 5531.4 5531.6 5548.1 5566.1 4863.7 5424.9 5442.7 5458.3 5472.4 4895.3 4896.9 4898.1 4930.0 4949.2 3621.2 3624.2 3634.4 3652.0 3657.1 5029.1 5170.9 5190.6 5195.4 5210.7 5050.2 5053.5 5055.0 5068.3 5071.9 5027.4 5055.6 5066.8 5070.3 5074.9 4780.4 4929.3 4965.6 4967.5 4970.9 5058.7 5077.0 5077.3 5086.5 5116.7 4959.2 4959.9 4965.8 4968.2 4993.8 02:07:04 INFO - PROCESS | 14048 | 02:07:04 INFO - PROCESS | 14048 | [#5] yui.html Cycles:180 Average:12193.68 Median:529.09 stddev:13998.02 (2645.7%) stddev-sans-first:14010.42 02:07:04 INFO - PROCESS | 14048 | Values: 644.3 691.7 743.0 764.9 793.5 11959.2 12025.0 12171.1 12196.0 12256.3 11243.5 11542.9 11543.4 11554.7 11932.2 628.9 776.8 790.7 796.2 805.5 800.4 803.3 803.8 804.4 804.9 840.7 844.6 844.6 844.8 845.0 646.8 805.5 829.7 830.5 835.9 610.7 611.1 611.2 611.2 611.3 12518.4 12541.4 12557.4 12588.2 12589.4 11527.8 12218.2 12678.1 12896.3 12930.9 9396.6 9506.1 9799.9 9856.9 9959.6 3168.9 3274.4 3290.9 3292.2 3301.5 43070.4 43307.0 43601.8 43649.8 43713.6 8838.6 8885.6 9219.3 9265.4 9313.9 16099.9 16232.5 16276.6 16299.8 16381.4 6366.3 6476.6 6481.6 6539.8 6634.6 3449.1 3541.2 3551.5 3645.5 3669.5 2868.0 2908.0 2923.3 2926.8 2929.3 506.2 507.0 510.4 514.5 521.4 420.5 536.8 541.4 546.0 592.5 6768.8 7022.8 7076.2 7134.1 7187.7 407.7 480.2 571.8 580.5 584.2 3357.0 3386.2 3416.2 3461.6 3476.6 47802.3 47937.8 48404.0 48634.0 49324.8 45746.3 46082.5 46652.8 46697.5 47009.3 42310.4 42461.8 42508.1 42787.0 43495.1 6958.4 7344.8 7381.1 7428.6 7487.0 28759.3 29067.0 29299.0 29534.1 29975.7 36226.8 37851.6 37889.4 38052.8 38180.6 9391.1 9474.2 9516.0 9554.1 9651.5 10295.5 10597.3 10716.2 10754.0 10998.6 9573.9 9679.3 9789.2 9869.6 9883.2 9932.8 9958.5 10027.3 10070.3 10171.8 9341.1 9383.4 9617.8 9663.9 9957.2 8603.0 8702.5 8819.0 8867.0 9174.5 8495.8 8587.5 8737.0 8740.9 8809.1 02:07:04 INFO - PROCESS | 14048 | -------- Summary: end -------- 02:07:04 INFO - PROCESS | 14048 | 02:07:05 INFO - TEST-INFO | 14048: exit 0 02:07:05 INFO - TEST-OK | dromaeo_css | took 1118189ms 02:07:05 INFO - TEST-START | kraken 02:07:05 INFO - operating with platform_type : linux_ 02:07:05 INFO - Initialising browser for kraken test... 02:07:05 INFO - TEST-INFO | started process 14227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUT5GoY/profile http://localhost:44586/getInfo.html) 02:07:09 INFO - PROCESS | 14227 | __metrics Screen width/height:1600/1200 02:07:09 INFO - PROCESS | 14227 | colorDepth:24 02:07:09 INFO - PROCESS | 14227 | Browser inner width/height: 1024/697 02:07:09 INFO - PROCESS | 14227 | __metrics 02:07:10 ERROR - PROCESS | 14227 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:07:11 INFO - TEST-INFO | 14227: exit 0 02:07:11 INFO - Browser initialized. 02:07:11 INFO - Running cycle 1/1 for kraken test... 02:07:11 INFO - TEST-INFO | started process 14308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUT5GoY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:23 INFO - PROCESS | 14308 | RSS: Main: 156262400 02:07:23 INFO - PROCESS | 14308 | 02:07:26 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44586/tests/kraken/driver.html?testName=audio-beat-detection) 02:07:27 INFO - PROCESS | 14308 | RSS: Main: 211390464 02:07:27 INFO - PROCESS | 14308 | 02:07:29 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44586/tests/kraken/driver.html?testName=audio-dft) 02:07:30 INFO - PROCESS | 14308 | RSS: Main: 197570560 02:07:30 INFO - PROCESS | 14308 | 02:07:33 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44586/tests/kraken/driver.html?testName=audio-fft) 02:07:34 INFO - PROCESS | 14308 | RSS: Main: 267739136 02:07:34 INFO - PROCESS | 14308 | 02:07:36 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44586/tests/kraken/driver.html?testName=audio-oscillator) 02:07:37 INFO - PROCESS | 14308 | RSS: Main: 176005120 02:07:37 INFO - PROCESS | 14308 | 02:07:39 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44586/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:07:39 INFO - PROCESS | 14308 | RSS: Main: 180322304 02:07:39 INFO - PROCESS | 14308 | 02:07:43 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44586/tests/kraken/driver.html?testName=imaging-darkroom) 02:07:43 INFO - PROCESS | 14308 | RSS: Main: 215343104 02:07:43 INFO - PROCESS | 14308 | 02:07:47 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44586/tests/kraken/driver.html?testName=imaging-desaturate) 02:07:47 INFO - PROCESS | 14308 | RSS: Main: 213401600 02:07:47 INFO - PROCESS | 14308 | 02:07:50 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44586/tests/kraken/driver.html?testName=json-parse-financial) 02:07:51 INFO - PROCESS | 14308 | RSS: Main: 214540288 02:07:51 INFO - PROCESS | 14308 | 02:07:53 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44586/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:07:53 INFO - PROCESS | 14308 | RSS: Main: 201510912 02:07:53 INFO - PROCESS | 14308 | 02:07:55 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44586/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:07:56 INFO - PROCESS | 14308 | RSS: Main: 203948032 02:07:56 INFO - PROCESS | 14308 | 02:07:58 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44586/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:07:59 INFO - PROCESS | 14308 | RSS: Main: 217862144 02:07:59 INFO - PROCESS | 14308 | 02:08:01 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:08:02 INFO - PROCESS | 14308 | RSS: Main: 225902592 02:08:02 INFO - PROCESS | 14308 | 02:08:05 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:08:05 INFO - PROCESS | 14308 | RSS: Main: 221597696 02:08:05 INFO - PROCESS | 14308 | 02:08:07 INFO - PROCESS | 14308 | Cycle 1(1): loaded http://localhost:44586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44586/tests/kraken/driver.html?testName=ai-astar) 02:08:08 INFO - PROCESS | 14308 | RSS: Main: 284315648 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | __start_tp_report 02:08:08 INFO - PROCESS | 14308 | _x_x_mozilla_page_load 02:08:08 INFO - PROCESS | 14308 | _x_x_mozilla_page_load_details 02:08:08 INFO - PROCESS | 14308 | |i|pagename|runs| 02:08:08 INFO - PROCESS | 14308 | |0;ai-astar;113;114;109;113;114;113;104;113;115;113 02:08:08 INFO - PROCESS | 14308 | |1;audio-beat-detection;164;144;158;184;135;168;161;135;192;138 02:08:08 INFO - PROCESS | 14308 | |2;audio-dft;162;161;164;161;161;161;161;162;161;162 02:08:08 INFO - PROCESS | 14308 | |3;audio-fft;76;77;112;110;77;79;77;114;102;80 02:08:08 INFO - PROCESS | 14308 | |4;audio-oscillator;94;95;144;94;95;100;141;93;93;151 02:08:08 INFO - PROCESS | 14308 | |5;imaging-gaussian-blur;118;118;117;117;117;116;117;119;116;117 02:08:08 INFO - PROCESS | 14308 | |6;imaging-darkroom;146;147;146;148;146;147;146;146;146;146 02:08:08 INFO - PROCESS | 14308 | |7;imaging-desaturate;95;95;95;94;95;94;94;95;95;95 02:08:08 INFO - PROCESS | 14308 | |8;json-parse-financial;68;70;69;68;69;71;69;84;68;66 02:08:08 INFO - PROCESS | 14308 | |9;json-stringify-tinderbox;65;65;67;65;66;66;65;66;66;66 02:08:08 INFO - PROCESS | 14308 | |10;stanford-crypto-aes;81;80;88;81;83;82;82;82;84;82 02:08:08 INFO - PROCESS | 14308 | |11;stanford-crypto-ccm;138;141;134;140;131;129;133;130;167;132 02:08:08 INFO - PROCESS | 14308 | |12;stanford-crypto-pbkdf2;180;174;175;175;175;173;177;176;174;175 02:08:08 INFO - PROCESS | 14308 | |13;stanford-crypto-sha256-iterative;74;78;74;73;73;74;73;74;75;74 02:08:08 INFO - PROCESS | 14308 | __end_tp_report 02:08:08 INFO - PROCESS | 14308 | __start_cc_report 02:08:08 INFO - PROCESS | 14308 | _x_x_mozilla_cycle_collect,1911 02:08:08 INFO - PROCESS | 14308 | __end_cc_report 02:08:08 INFO - PROCESS | 14308 | __startTimestamp1462007288038__endTimestamp 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | ------- Summary: start ------- 02:08:08 INFO - PROCESS | 14308 | Number of tests: 14 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.25 (2.9%) stddev-sans-first:3.43 02:08:08 INFO - PROCESS | 14308 | Values: 113.0 114.0 109.0 113.0 114.0 113.0 104.0 113.0 115.0 113.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#1] audio-beat-detection Cycles:10 Average:157.90 Median:162.50 stddev:20.09 (12.4%) stddev-sans-first:21.18 02:08:08 INFO - PROCESS | 14308 | Values: 164.0 144.0 158.0 184.0 135.0 168.0 161.0 135.0 192.0 138.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 02:08:08 INFO - PROCESS | 14308 | Values: 162.0 161.0 164.0 161.0 161.0 161.0 161.0 162.0 161.0 162.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#3] audio-fft Cycles:10 Average:90.40 Median:77.00 stddev:16.75 (21.8%) stddev-sans-first:16.94 02:08:08 INFO - PROCESS | 14308 | Values: 76.0 77.0 112.0 110.0 77.0 79.0 77.0 114.0 102.0 80.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:93.50 stddev:24.58 (26.3%) stddev-sans-first:25.38 02:08:08 INFO - PROCESS | 14308 | Values: 94.0 95.0 144.0 94.0 95.0 100.0 141.0 93.0 93.0 151.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 02:08:08 INFO - PROCESS | 14308 | Values: 118.0 118.0 117.0 117.0 117.0 116.0 117.0 119.0 116.0 117.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 02:08:08 INFO - PROCESS | 14308 | Values: 146.0 147.0 146.0 148.0 146.0 147.0 146.0 146.0 146.0 146.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:08:08 INFO - PROCESS | 14308 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#8] json-parse-financial Cycles:10 Average:70.20 Median:69.00 stddev:5.03 (7.3%) stddev-sans-first:5.27 02:08:08 INFO - PROCESS | 14308 | Values: 68.0 70.0 69.0 68.0 69.0 71.0 69.0 84.0 68.0 66.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 02:08:08 INFO - PROCESS | 14308 | Values: 65.0 65.0 67.0 65.0 66.0 66.0 65.0 66.0 66.0 66.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:2.22 (2.7%) stddev-sans-first:2.29 02:08:08 INFO - PROCESS | 14308 | Values: 81.0 80.0 88.0 81.0 83.0 82.0 82.0 82.0 84.0 82.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:136.00 stddev:11.17 (8.2%) stddev-sans-first:11.84 02:08:08 INFO - PROCESS | 14308 | Values: 138.0 141.0 134.0 140.0 131.0 129.0 133.0 130.0 167.0 132.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:175.00 stddev:1.96 (1.1%) stddev-sans-first:1.17 02:08:08 INFO - PROCESS | 14308 | Values: 180.0 174.0 175.0 175.0 175.0 173.0 177.0 176.0 174.0 175.0 02:08:08 INFO - PROCESS | 14308 | 02:08:08 INFO - PROCESS | 14308 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:74.00 stddev:1.48 (2.0%) stddev-sans-first:1.56 02:08:08 INFO - PROCESS | 14308 | Values: 74.0 78.0 74.0 73.0 73.0 74.0 73.0 74.0 75.0 74.0 02:08:08 INFO - PROCESS | 14308 | -------- Summary: end -------- 02:08:08 INFO - PROCESS | 14308 | 02:08:09 INFO - TEST-INFO | 14308: exit 0 02:08:09 INFO - TEST-OK | kraken | took 63838ms 02:08:09 INFO - SUITE-END | took 1182s 02:08:09 INFO - Completed test suite (00:19:42) 02:08:09 INFO - javascript benchmark 02:08:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.9617655735165, 2596.052440859087, 2623.435961268327, 2632.921012369629, 2637.1165659504063, 4563.771811409424, 4595.058013107313, 4600.907981840365, 4618.44578650562, 4637.211674015417, 4577.176108300505, 4620.537946205378, 4641.164590373732, 4697.037107392985, 4731.408573928259, 4216.430781844442, 4219.177260434217, 4255.936160957588, 4277.55085716, 4350.847720329789, 4309.095090031082, 4325.437693099892, 4334.45819272591, 4373.781310934456, 4379.627731642814, 4152.875413737593, 4179.331306990867, 4239.982404222964, 4253.851115210953, 4256.084941737541, 4204.936925946114, 4241.745495270263, 4246.426732391118, 4285.721428107194, 4300.204462174508, 4130.070734084837, 4240.406343111967, 4251.319788833803, 4256.553061928515, 4286.485621725382, 4441.977790111029, 4538.160440318552, 4579.7252164870215, 4581.106684196583, 4634.907301853944, 4886.389201349832, 4908.116539022974, 4908.214685650314, 4911.778969946361, 4946.72792996385, 4898.779554920037, 4916.459189489154, 4916.50834916509, 4972.602191824645, 4980.975095124538, 4569.95430045702, 4608.654350923694, 4633.62930965522, 4722.008378240539, 4722.079194557097, 5044.722540260321, 5053.065182941167, 5058.468860769566, 5069.822556210589, 5072.797088116507, 4877.12211801879, 4882.902341953141, 4895.192293271642, 4895.314655948099, 4929.679570827885, 4811.158047341702, 4895.853124406273, 4967.875803104951, 4975.800967961313, 4983.302337672729, 4908.6073114151495, 4908.828191013297, 4918.360613120271, 4921.655484116149, 4964.702117872939, 4886.804527818918, 4896.975515122402, 4909.386326709161, 4913.48408417111, 4944.159492886218, 4162.0, 4178.561251068594, 4232.280512312853, 4257.893552661147, 4264.530901600821, 3674.8530058797883, 3683.079230192452, 3690.686291665185, 3710.18375957289, 3717.237966216919, 4262.339337402707, 4263.275243208662, 4266.637335826427, 4299.247631664446, 4313.029568347097, 4889.975550122298, 4914.950850491449, 4918.852434426973, 4971.552560269593, 5011.173156429149, 4301.913961720748, 4309.224339618899, 4327.588879056485, 4338.544452832471, 4373.343998400265, 4502.954970450319, 4529.497685242505, 4533.591976722111, 4539.7049191802425, 4571.291449825282, 4568.291914753285, 4605.746683932416, 4668.369770080995, 4674.7896344663895, 4724.2205036169335, 4938.925916111333, 4985.277134815359, 4996.500349964975, 4998.6750861193905, 5048.040872234411, 4673.579377856009, 4683.976580117078, 4695.765211739331, 4701.600363968964, 4746.762661866824, 4783.784729687242, 4809.879753006203, 4858.7570621469495, 4887.853364399074, 4896.387951506062, 4947.82682606107, 4957.03337849116, 4978.4025916890205, 5004.649674522894, 5023.547880690755, 4716.33971244033, 4850.175470170009, 4863.416390033219, 4866.318715379921, 4917.729524876167, 4737.644676649334, 4782.665213435165, 4788.473267940454, 4828.227483602606, 4829.13075646387, 4748.762561871962, 4794.808207671794, 4796.592289655278, 4805.063012712488, 4850.175470170009, 4748.31149483316, 4831.396075490564, 4886.193778026728, 4912.410510738734, 4962.181240095344, 4771.785269662943, 4772.928406073981, 4786.401699787527, 4833.637477189154, 4836.347093142381], "value": 4553.011614853297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.618913486789, 583.932847722512, 587.5740088435884, 604.9999999999999, 619.3868070610092, 33024.5046324305, 33865.0, 34367.82816085922, 34421.0, 34422.65577344226, 36497.27005459896, 37310.44034339487, 37363.0, 37441.0, 37446.43830342547, 7293.197748247689, 7344.669489872956, 7598.0, 9501.42991420517, 9722.805543889119, 9675.951620241889, 9863.802723945517, 9865.506724663774, 9870.901290987105, 9878.60485580576, 10026.69919902404, 10226.130778883804, 10230.335028223179, 10237.692869213935, 10239.744006399862, 10017.298789084767, 10118.747031324203, 10135.0, 10147.492625368775, 10154.086132248132, 9985.05142011515, 10119.0, 10130.493475326204, 10136.847947280796, 10136.847947280796, 37019.25961480782, 37590.0, 37677.0, 37717.811410943046, 37725.811370943244, 3089.845507724605, 3136.592243008417, 3208.8395580220895, 3433.8111403872776, 3739.869104581354, 28936.276593085342, 29134.0, 29378.265543361587, 29880.25299367533, 30275.0, 3469.2194256292387, 3488.180277634754, 3490.738194635387, 3537.6285490023433, 3573.76770509916, 250158.0, 252426.0, 253031.0, 253090.0, 253641.0, 46365.5363446368, 46988.0, 46989.5301046992, 47016.0, 47122.29316560255, 55576.16635750467, 55854.72072639611, 55883.0, 55891.44108558862, 55984.0, 14740.336684849208, 15291.158986255863, 15301.846981530265, 15308.846911530742, 15309.923450382677, 11762.235454695418, 11851.525938962517, 11889.762204755856, 11889.821652675217, 11893.34586597728, 15646.295916683777, 15735.68528629421, 15795.36818527269, 15805.604859878595, 15859.841401585836, 5850.765969361178, 5851.297844258716, 5956.374580669054, 5958.374370691102, 6014.188084608521, 839.4585492357395, 889.8042430665244, 908.3550679017972, 955.254901177083, 996.1930836022844, 27773.166804995883, 28061.719382806317, 28104.156875293775, 28415.71584284172, 28804.42391152207, 989.4557993103764, 1022.3405903192399, 1094.370736826328, 1106.3693694594165, 1127.4081107418506, 14608.707825843423, 15045.548633541011, 15170.924145379202, 15210.183333914994, 15367.077975321516, 329709.0, 330536.0, 334114.0, 334509.0, 335132.0, 50169.74915125401, 50413.74793126084, 50558.0, 50570.0, 50586.241206381936, 1094.5129417409175, 1197.126097948485, 1201.6335017819474, 1250.881166289201, 1294.9093563450656, 27586.172414827586, 28919.0, 29125.41749165047, 29480.0, 29638.40723185481, 39640.40539391969, 40458.0, 40459.39310910398, 40487.0, 41126.38310425286, 268183.0, 268280.0, 270205.0, 270815.9806416398, 271435.0, 20486.0, 22959.88520057389, 23160.536789263784, 23350.76649233486, 24712.13507527228, 36797.81601091977, 36930.44604330991, 37421.43867842039, 37574.81212594029, 37745.245095097394, 31541.842290788398, 32068.0, 34042.31915361728, 34819.30361392809, 35256.29487410289, 34264.0, 34742.0, 34829.825850870584, 35044.474332884514, 35271.11822204466, 32314.676853231165, 34317.65682343145, 34513.13717157091, 34742.305153896275, 34778.30443391067, 27280.181594552196, 27646.861765691043, 28822.855885720437, 29963.400731984802, 31813.363732724752, 24265.029398824554, 24364.390890227885, 24553.263402097964, 25002.874985625684, 25107.87446062758], "value": 17531.612692175106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.5262243262272, 376.6628867163888, 383.18573032306347, 384.7633705271259, 391.82367934429516, 15591.298391572378, 16357.427490037837, 17174.39889603864, 17192.054437005958, 17193.398231061914, 15725.685486290267, 16233.188340582983, 16452.341906323734, 16470.258838352274, 16475.2586133624, 4586.610138138254, 4860.05228980349, 4876.707397556141, 4880.341153944225, 4881.853544393656, 3527.2416430467442, 3727.90680232995, 5406.648567843077, 5707.3721890592005, 5709.4290570942785, 5671.461211184951, 5674.829755107333, 5678.659280443187, 5684.374718780951, 5698.772049118031, 5301.7084060376665, 5599.1041433370465, 5599.468050535193, 5604.41153678864, 5610.69141197234, 3458.602260740022, 5178.456262092502, 5462.0, 5469.316335458067, 5470.17947307903, 12181.0, 12264.0, 12310.13829031968, 12314.5074197032, 12422.565210217599, 1908.0624798871286, 1996.0019990004998, 2185.7377114746173, 2301.735300440437, 2448.1553863917097, 9066.184043436122, 9348.345615806897, 9573.952130239373, 10228.0, 12821.423035963404, 1726.965460690779, 1746.956326091845, 1782.643471305731, 1842.3551756885117, 1845.3541260558832, 66460.33539664638, 71028.28971710269, 72362.27637723608, 73338.0, 73868.26131738721, 9980.700578982642, 10009.399436033862, 10059.849102263472, 10132.645357412455, 10243.539040743184, 14038.929805350908, 14140.717185656229, 14141.575752727435, 14147.43410263578, 14180.361883715257, 7302.087239095114, 7319.817004574928, 7329.267073292628, 7375.971607807788, 7513.436492263102, 6748.966255168692, 6762.763303284361, 6775.525713200127, 6867.07294515244, 6872.828179295458, 4057.472528571267, 4098.7950602469755, 4104.4048612950955, 4116.0533077391765, 4186.434831297796, 1712.8458438740572, 1769.2834402067183, 1788.2399980008445, 1804.7202683584067, 1838.4025191812714, 792.3859009267863, 826.574314228173, 861.2076889261895, 886.6453418632469, 943.2689665509148, 15431.61420964485, 16476.0, 16480.67038659244, 16649.50051498457, 17021.0, 822.4859462835727, 847.1147650705028, 855.4482358878613, 859.1837754133599, 927.7355953553205, 9037.548122593844, 9171.44971301724, 9326.487043212554, 9661.0, 9678.903210967801, 388306.0, 395419.0, 401932.0, 402585.0, 404416.0, 68572.0, 75954.6202268985, 79113.60443197747, 79192.60403697945, 80589.59705201436, 839.9496030238205, 919.5080631861922, 934.6541779541477, 971.223021582731, 979.7354714227118, 14197.083393741712, 14723.631909202355, 14937.701245975237, 15042.473513426978, 15817.525474235792, 32633.836830815693, 32731.018069457954, 33684.99999999902, 34235.65764342325, 36122.27755444929, 42299.7885010573, 44589.33116003198, 47460.288095677904, 48376.758116209196, 48614.0, 7401.777946661608, 7605.0, 7683.0780306363595, 7692.115406728298, 7721.729739459317, 6837.965810170917, 9224.446533208029, 11083.682301088302, 11345.489452974802, 11390.943045284721, 9115.726528204164, 9140.268778497571, 9292.16370526656, 9340.34617576763, 9376.0, 8992.415492992934, 9892.505374731378, 9963.153131983572, 9983.0, 10048.849267261143, 9092.272618190662, 9169.449833010041, 9400.670976515788, 9493.28800339991, 9705.466199359103, 7178.102737157856, 7218.133823941161, 7368.115826100902, 7397.926020739724, 7464.253574642492, 7674.731384401519, 8680.088590697886, 8941.418807777474, 9128.361014728906, 9202.769930751518], "value": 7912.324349963782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.5012419969914, 1438.690681503477, 1471.4849802569101, 1585.6353038801076, 1754.9034803085826, 6671.733130674773, 7466.589337586437, 7679.116901556323, 7688.769336919901, 7708.344790692798, 7493.175750667422, 7644.847103057936, 7647.61761911905, 7648.388128949685, 7658.578778167199, 1897.5635603811131, 1970.9901450492728, 1973.8124878136625, 2145.1097794415336, 2182.6507758758603, 1971.4085774267662, 2174.7825217478285, 2254.3800454874877, 2257.559775843703, 2258.0516183203094, 2135.903884325209, 2157.094020511381, 2163.978360216401, 2165.1988764157286, 2165.8267338612873, 1824.188236234876, 2127.8084972352485, 2130.499332656824, 2130.6164890319737, 2138.0592539282743, 2114.640511113099, 2186.5954798362354, 2189.4416923684516, 2190.244365693833, 2192.024549075662, 7402.555846649218, 7441.479096463249, 7449.068866391701, 7451.068616422947, 7456.030716006884, 4403.207422663919, 4557.931631025537, 4564.954350456486, 4572.679912406133, 4584.060267645124, 2746.3134216445887, 2836.4327134572964, 2961.718636729507, 2991.3568582754597, 2993.625796775403, 884.2572239318939, 935.0742764662934, 950.334765664031, 1689.2820551265786, 1742.6427582345589, 10181.185505159643, 10242.0, 10253.23100767438, 10258.230632702576, 10273.486325683685, 3996.5603783583783, 4081.285774989365, 4147.854825081168, 4183.5398106208295, 4183.769892655872, 8197.34421246299, 8202.343812494986, 8210.548419836847, 8230.958845205736, 8243.299319557786, 4603.654725895572, 4666.906661866744, 4667.649926255544, 4692.601128904082, 4698.694584851974, 3713.0, 3824.579296277407, 4238.703290769617, 4337.566243375637, 4370.060437006059, 3370.612379576331, 3455.222574920673, 3478.9652103479148, 3485.634008429129, 3490.5636795400574, 1020.4948550467566, 1063.5426766490484, 1063.984040239397, 1067.4716015572342, 1071.8017166824006, 877.3288434347729, 879.5821984557284, 894.6466145872344, 902.5848109869534, 910.717677519971, 5425.511703946664, 5462.9726851365485, 5475.7262136893, 5558.749856256478, 5609.943900561024, 407.2974119643591, 409.68863663615866, 415.8295099009392, 419.5447938986234, 421.0463300624089, 3738.6448287412654, 3745.962540374616, 3779.7543159694533, 3818.866339678098, 3862.2661694278, 9362.765930851783, 9794.167495762798, 9826.606935722633, 9925.255605829447, 9936.354136981074, 9533.094356036165, 9713.36863103896, 9790.804183916282, 9830.459324737065, 9847.901520984842, 7361.153467351323, 7380.520266182681, 7438.070241219848, 7465.440091993122, 7498.437617178624, 5354.919676204938, 5442.727863606883, 5493.725313734218, 5568.805091821767, 5602.047651899105, 8601.483910965362, 9011.729648110568, 9074.364794464323, 9135.223506002065, 9154.908450915405, 8848.46909185451, 9096.499692516974, 9153.359264851397, 9240.214581760625, 9284.535773211448, 5490.670559766427, 5739.311282646109, 5740.311162660508, 6317.084022816574, 6414.775482858077, 6731.922892337203, 7449.106107267163, 7538.208488108669, 7549.3583045439555, 7587.62061896914, 6596.5052621052655, 6651.301613330531, 6778.796636100925, 6811.8978215325815, 6901.827454313682, 6663.502136058239, 6692.732290708512, 6703.396694297341, 6743.797686069426, 6753.2909044549615, 6188.8762224754355, 6229.688515574113, 6254.749810007549, 6256.812295631138, 6260.874782504416, 4606.700564463299, 4661.230896902109, 4761.666683332133, 4862.41651001882, 4871.391076115486, 4714.882127946692, 4759.476457589732, 4759.9286010709175, 4833.347498087714, 4835.129676658235], "value": 4051.6286571873725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.36429408976363, 306.97237248647616, 309.78934324659224, 312.49220017471623, 312.7748021424574, 4729.692569982953, 4794.1130890785225, 4800.159972004903, 4814.229723244282, 4836.516348365161, 4765.070811191819, 4769.761511924407, 4777.593904518111, 4778.71327720337, 4784.736839473836, 3805.1058001369656, 3807.999999999993, 3811.8284677189454, 3814.5231846019246, 3835.5972622874615, 3689.465027571014, 3806.371948628473, 3820.1595648957186, 3820.3505404081234, 3821.7515861469055, 3688.612695666943, 3736.9813150934206, 3768.773873567581, 3783.81080945953, 3801.467794508771, 3724.832382542792, 3734.7012239020814, 3743.2326373093724, 3758.699304055669, 3765.9246815063684, 3137.2784259620416, 3205.1506350817053, 3319.203391186122, 3346.0631023313513, 3365.209175843675, 4556.248219043854, 4557.726536407793, 4559.52125026874, 4574.908501829945, 4585.72485650862, 4258.701890867641, 4272.2950713132295, 4282.764447955361, 4289.463817022872, 4301.139772045603, 4716.952830471686, 4742.454617718972, 4923.153817318505, 4971.875703107415, 4988.825391111293, 3642.817859107034, 3657.579378371495, 3663.9267214655556, 3664.5236119304586, 3668.4497325401135, 5189.636725429222, 5197.8960420791755, 5206.843794686166, 5215.452377500384, 5224.216367544861, 3523.2342611050203, 3655.3420384331075, 3670.559532856021, 3676.209614932802, 3767.868124615625, 3665.450182472597, 3677.5770786359376, 3689.815509224528, 3727.6272372762505, 3728.8694895678523, 4190.350495673176, 4202.159568086395, 4212.157568486254, 4231.286329036745, 4238.1099969006855, 4788.449328327218, 5022.271770593316, 5030.378127748016, 5039.748012599355, 5046.949530504721, 1354.6681063139595, 1355.4103964775354, 1357.7915655066997, 1358.5380970470087, 1364.8293963254594, 851.5444237332997, 860.6643409070467, 863.7322430046705, 872.4721543466238, 880.221004411088, 4723.551262630044, 4723.913499895043, 4737.407824021997, 4746.952530474651, 4749.4063242094735, 5546.55627549795, 5552.444755524496, 5560.277163968658, 5560.888782224333, 5568.911658128202, 4660.39414876064, 4688.5304874392705, 4749.0, 4766.832126129051, 4773.427188737373, 2770.7090755470385, 2853.629028226317, 2941.5881776550873, 2964.6294213223346, 2965.599644048069, 5224.92162617561, 5227.0, 5234.607404444682, 5239.842804715865, 5240.659357141773, 5661.264035675335, 5667.3482549507335, 5671.546276297886, 5690.9146362804595, 5699.373068962411, 4975.825846095369, 5183.3261675981885, 5216.791328346823, 5234.97382513085, 5240.161574148118, 5515.338159420895, 5531.419200984, 5531.585131115263, 5548.112302031817, 5566.109422492382, 4863.659543831898, 5424.945750542444, 5442.727863606883, 5458.344998600034, 5472.398036216093, 4895.314655948099, 4896.902061958812, 4898.142825005539, 4930.038642464685, 4949.183384741477, 3621.1713084893013, 3624.2389098289655, 3634.3639863024396, 3651.9817400912825, 3657.085728567858, 5029.0947629427055, 5170.922436163536, 5190.6107041972755, 5195.402528709095, 5210.687358758487, 5050.247615049881, 5053.469385714447, 5054.974725126351, 5068.29043933857, 5071.949280507148, 5027.4218464877, 5055.570276526537, 5066.82266120684, 5070.290159377764, 5074.873128171826, 4780.378550788375, 4929.309896614549, 4965.627577931597, 4967.4535801062575, 4970.875728106682, 5058.671186372874, 5077.019962214666, 5077.258280528473, 5086.542211200862, 5116.74416279192, 4959.231319145538, 4959.925601115914, 4965.751712414437, 4968.205087186033, 4993.775280112476], "value": 3865.7060303097937, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.2912795924483, 691.7025678958049, 742.9888551671726, 764.9471869364464, 793.4763056382785, 11959.162858599902, 12025.037996960244, 12171.14801963863, 12196.0, 12256.26462412256, 11243.494042768074, 11542.884571154285, 11543.422828858565, 11554.653360399201, 11932.224405413664, 628.940250676185, 776.809681628002, 790.7271991163054, 796.2475460689651, 805.472415567804, 800.3557136505111, 803.2931020701774, 803.8311954489565, 804.3565147881701, 804.9114597394282, 840.6805413942693, 844.5734903873536, 844.6072576252042, 844.8056946902216, 844.995775021124, 646.844757258257, 805.4563169860321, 829.7386323308169, 830.4643504939311, 835.9205875441824, 610.6824451285352, 611.0894766797484, 611.1596554737237, 611.1901730207493, 611.2512172588588, 12518.436670349856, 12541.435635396429, 12557.372131393486, 12588.181768185039, 12589.433475493624, 11527.827082593767, 12218.20581662189, 12678.112532122756, 12896.290704011275, 12930.870691293061, 9396.62413503459, 9506.08091337801, 9799.90200097997, 9856.852147217798, 9959.601615935353, 3168.889088881901, 3274.4269752793402, 3290.851911663981, 3292.193412613901, 3301.5377847101427, 43070.353944690854, 43307.0, 43601.78199108984, 43649.78175109104, 43713.56286437158, 8838.602262898185, 8885.555722213992, 9219.262459003263, 9265.397749146285, 9313.90686093144, 16099.919500402422, 16232.513024609281, 16276.593085172966, 16299.837001629832, 16381.426650067191, 6366.26787919386, 6476.579022363531, 6481.578697384655, 6539.771108011197, 6634.568753031134, 3449.0859922120158, 3541.203229273393, 3551.5027896094566, 3645.4714066460215, 3669.541307336583, 2867.971320286812, 2907.956380654292, 2923.342247994184, 2926.824390536575, 2929.3262549613282, 506.2431664661281, 506.98225562105887, 510.39008384979593, 514.4906542522875, 521.3535216331798, 420.4849059901657, 536.8255317021983, 541.3584901891271, 545.9972700136474, 592.4904582059512, 6768.796936091827, 7022.789316320519, 7076.221615622278, 7134.143902731602, 7187.748428804966, 407.7105255268792, 480.2268347959782, 571.8141603978723, 580.4775701868352, 584.2288179602969, 3357.0, 3386.153461634591, 3416.1801167720064, 3461.6019157797177, 3476.617572067071, 47802.28296575554, 47937.760311198916, 48404.0, 48634.0, 49324.75337623361, 45746.31380529295, 46082.53917460849, 46652.833679157615, 46697.53302466932, 47009.29907009272, 42310.36534451986, 42461.78769106135, 42508.14983700309, 42787.0, 43495.130097398505, 6958.43233946083, 7344.779656610311, 7381.1432754509215, 7428.6285685716575, 7486.962565187139, 28759.281017974718, 29067.0, 29299.0, 29534.11397658074, 29975.700242997293, 36226.8188659055, 37851.62148378481, 37889.43165852459, 38052.809735951145, 38180.6181938177, 9391.107844754737, 9474.194693450858, 9515.952420237854, 9554.092361225672, 9651.517424128906, 10295.485225738832, 10597.2581919268, 10716.249862509861, 10754.0, 10998.560057597606, 9573.856392153984, 9679.322447428613, 9789.216862650828, 9869.555869986012, 9883.209343252378, 9932.801343973224, 9958.50207489637, 10027.298089133983, 10070.345427547187, 10171.84742228882, 9341.11259430353, 9383.436993780122, 9617.807643847224, 9663.855042174513, 9957.153641940517, 8603.0, 8702.521361325187, 8819.0, 8867.0, 9174.541272936192, 8495.787605309917, 8587.484750914966, 8736.956315218638, 8740.912590874264, 8809.11908809114], "value": 5633.596634902476, "unit": "score"}], "name": "dromaeo_css", "value": 6180.446142734906, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 109.0, 113.0, 114.0, 113.0, 104.0, 113.0, 115.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 144.0, 158.0, 184.0, 135.0, 168.0, 161.0, 135.0, 192.0, 138.0], "value": 157.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 112.0, 110.0, 77.0, 79.0, 77.0, 114.0, 102.0, 80.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 144.0, 94.0, 95.0, 100.0, 141.0, 93.0, 93.0, 151.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 119.0, 116.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 68.0, 69.0, 71.0, 69.0, 84.0, 68.0, 66.0], "value": 70.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 88.0, 81.0, 83.0, 82.0, 82.0, 82.0, 84.0, 82.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 134.0, 140.0, 131.0, 129.0, 133.0, 130.0, 167.0, 132.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 174.0, 175.0, 175.0, 175.0, 173.0, 177.0, 176.0, 174.0, 175.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 74.0, 73.0, 73.0, 74.0, 73.0, 74.0, 75.0, 74.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1595.8000000000002, "alertThreshold": 2.0}]} 02:08:09 INFO - Return code: 0 02:08:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:08:09 ERROR - # TBPL SUCCESS # 02:08:09 INFO - Running post-action listener: _resource_record_post_action 02:08:09 INFO - Running post-run listener: _resource_record_post_run 02:08:10 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527945728; Read time: 20; Write time: 542956 02:08:10 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 248987648; Read time: 0; Write time: 365792 02:08:10 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278843392; Read time: 20; Write time: 177164 02:08:10 INFO - Running post-run listener: _upload_blobber_files 02:08:10 INFO - Blob upload gear active. 02:08:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:08:10 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 02:08:10 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'] 02:08:10 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 02:08:10 INFO - (blobuploader) - INFO - Open directory for files ... 02:08:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:08:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:08:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:11 INFO - (blobuploader) - INFO - Done attempting. 02:08:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:08:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:08:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:12 INFO - (blobuploader) - INFO - Done attempting. 02:08:12 INFO - (blobuploader) - INFO - Iteration through files over. 02:08:12 INFO - Return code: 0 02:08:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:08:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:08:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14235dff2d683c16b562f69804f304b107d0306b6b1cfea18f9e479d139fa5b5afbd576651f88fb4fe3e1c406aee3c4ceacf0db3d87f5601049af0bfbf6033e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87ac7ef24a0b71bb02b30e2578930eb739c4a42404d144d160ddc089821d8792622874943e9ca5a02858ea92e52680aa78c512ecb24bdefe04a94dca1e993208"} 02:08:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:08:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:08:12 INFO - Contents: 02:08:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14235dff2d683c16b562f69804f304b107d0306b6b1cfea18f9e479d139fa5b5afbd576651f88fb4fe3e1c406aee3c4ceacf0db3d87f5601049af0bfbf6033e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87ac7ef24a0b71bb02b30e2578930eb739c4a42404d144d160ddc089821d8792622874943e9ca5a02858ea92e52680aa78c512ecb24bdefe04a94dca1e993208"} 02:08:12 INFO - Running post-run listener: copy_logs_to_upload_dir 02:08:12 INFO - Copying logs to upload dir... 02:08:12 INFO - mkdir: /builds/slave/test/build/upload/logs 02:08:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.502927 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-30 02:08:12.175449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 02:08:12.179625) ========= 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=cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088 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/14235dff2d683c16b562f69804f304b107d0306b6b1cfea18f9e479d139fa5b5afbd576651f88fb4fe3e1c406aee3c4ceacf0db3d87f5601049af0bfbf6033e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87ac7ef24a0b71bb02b30e2578930eb739c4a42404d144d160ddc089821d8792622874943e9ca5a02858ea92e52680aa78c512ecb24bdefe04a94dca1e993208"} build_url:https://queue.taskcluster.net/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/b-9BhMgpSrCRPLaaAQ04Uw/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/14235dff2d683c16b562f69804f304b107d0306b6b1cfea18f9e479d139fa5b5afbd576651f88fb4fe3e1c406aee3c4ceacf0db3d87f5601049af0bfbf6033e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87ac7ef24a0b71bb02b30e2578930eb739c4a42404d144d160ddc089821d8792622874943e9ca5a02858ea92e52680aa78c512ecb24bdefe04a94dca1e993208"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 02:08:12.205119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 02:08:12.205485) ========= 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=cbe409c6de289db6ac707de3000001d4-1462004521.450396-599995088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 02:08:12.291219) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 02:08:12.291576) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 02:08:12.291892) ========= ========= Total master_lag: 0.19 =========