builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1462485117.91 results: success (0) buildid: 20160505142107 builduid: 5ff692bcf09146beadbd427f348b434b revision: daa53f98b541117b380d848f34eb00570ae71d2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:57.909949) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:57.910451) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:57.910735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:57.923971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:57.924303) ========= 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=32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 14:51:57-- 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% 213M=0s 2016-05-05 14:51:58 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077198 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:58.012507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:58.012817) ========= 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=32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017359 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:58.062413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 14:51:58.062775) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev daa53f98b541117b380d848f34eb00570ae71d2b --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 daa53f98b541117b380d848f34eb00570ae71d2b --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=32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 14:51:58,151 truncating revision to first 12 chars 2016-05-05 14:51:58,151 Setting DEBUG logging. 2016-05-05 14:51:58,151 attempt 1/10 2016-05-05 14:51:58,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/daa53f98b541?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 14:51:59,018 unpacking tar archive at: fx-team-daa53f98b541/testing/mozharness/ program finished with exit code 0 elapsedTime=1.247404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 14:51:59.323535) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:59.323857) ========= script_repo_revision: daa53f98b541117b380d848f34eb00570ae71d2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:59.324244) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:59.324520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 14:51:59.334185) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-05 14:51:59.334529) ========= /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=32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:51:59 INFO - MultiFileLogger online at 20160505 14:51:59 in /builds/slave/test 14:51:59 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 14:51:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:51:59 INFO - {'append_to_log': False, 14:51:59 INFO - 'base_work_dir': '/builds/slave/test', 14:51:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:51:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:51:59 INFO - 'branch': 'Fx-Team-Non-PGO', 14:51:59 INFO - 'buildbot_json_path': 'buildprops.json', 14:51:59 INFO - 'config_files': ('talos/linux_config.py',), 14:51:59 INFO - 'default_actions': ('clobber', 14:51:59 INFO - 'read-buildbot-config', 14:51:59 INFO - 'download-and-extract', 14:51:59 INFO - 'populate-webroot', 14:51:59 INFO - 'create-virtualenv', 14:51:59 INFO - 'install', 14:51:59 INFO - 'run-tests'), 14:51:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:51:59 INFO - 'download_minidump_stackwalk': True, 14:51:59 INFO - 'download_symbols': 'ondemand', 14:51:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:51:59 INFO - 'tooltool.py': '/tools/tooltool.py', 14:51:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:51:59 INFO - '/tools/misc-python/virtualenv.py')}, 14:51:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:51:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:51:59 INFO - 'installer_path': 'installer.exe', 14:51:59 INFO - 'log_level': 'info', 14:51:59 INFO - 'log_name': 'talos', 14:51:59 INFO - 'log_to_console': True, 14:51:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:51:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:51:59 INFO - 'opt_config_files': (), 14:51:59 INFO - 'pip_index': False, 14:51:59 INFO - 'sps_profile': False, 14:51:59 INFO - 'sps_profile_interval': 0, 14:51:59 INFO - 'suite': 'dromaeojs', 14:51:59 INFO - 'system_bits': '32', 14:51:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:51:59 INFO - 'title': 'talos-linux64-ix-008', 14:51:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:51:59 INFO - 'use_talos_json': True, 14:51:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:51:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:51:59 INFO - 'work_dir': 'build'} 14:51:59 INFO - ##### 14:51:59 INFO - ##### Running clobber step. 14:51:59 INFO - ##### 14:51:59 INFO - Running pre-action listener: _resource_record_pre_action 14:51:59 INFO - Running main action method: clobber 14:51:59 INFO - rmtree: /builds/slave/test/build 14:51:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:52:00 INFO - Running post-action listener: _resource_record_post_action 14:52:00 INFO - ##### 14:52:00 INFO - ##### Running read-buildbot-config step. 14:52:00 INFO - ##### 14:52:00 INFO - Running pre-action listener: _resource_record_pre_action 14:52:00 INFO - Running main action method: read_buildbot_config 14:52:00 INFO - Using buildbot properties: 14:52:00 INFO - { 14:52:00 INFO - "project": "", 14:52:00 INFO - "product": "firefox", 14:52:00 INFO - "script_repo_revision": "production", 14:52:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:52:00 INFO - "repository": "", 14:52:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:52:00 INFO - "buildid": "20160505142107", 14:52:00 INFO - "pgo_build": "False", 14:52:00 INFO - "basedir": "/builds/slave/test", 14:52:00 INFO - "buildnumber": 1652, 14:52:00 INFO - "slavename": "talos-linux64-ix-008", 14:52:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:52:00 INFO - "platform": "ubuntu64_hw", 14:52:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:52:00 INFO - "branch": "fx-team", 14:52:00 INFO - "repo_path": "integration/fx-team", 14:52:00 INFO - "revision": "daa53f98b541117b380d848f34eb00570ae71d2b", 14:52:00 INFO - "stage_platform": "linux64", 14:52:00 INFO - "builduid": "5ff692bcf09146beadbd427f348b434b", 14:52:00 INFO - "slavebuilddir": "test" 14:52:00 INFO - } 14:52:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:52:00 INFO - Running post-action listener: _resource_record_post_action 14:52:00 INFO - ##### 14:52:00 INFO - ##### Running download-and-extract step. 14:52:00 INFO - ##### 14:52:00 INFO - Running pre-action listener: _resource_record_pre_action 14:52:00 INFO - Running main action method: download_and_extract 14:52:00 INFO - mkdir: /builds/slave/test/build/tests 14:52: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')]} 14:52:00 INFO - https://queue.taskcluster.net/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:52:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:52:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:52:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/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 14:52:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/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 14:52:01 INFO - Downloaded 1361 bytes. 14:52:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:52:01 INFO - Using the following test package requirements: 14:52:01 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:52:01 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:52:01 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:52:01 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:01 INFO - u'jsshell-linux-x86_64.zip'], 14:52:01 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:52:01 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:52:01 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:52:01 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:52:01 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:52:01 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:52:01 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:01 INFO - https://queue.taskcluster.net/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:52:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:52:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:52:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/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 14:52:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/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 14:52:03 INFO - Downloaded 22321318 bytes. 14:52:03 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'] 14:52:03 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 14:52:04 INFO - Return code: 0 14:52:04 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 14:52: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')]} 14:52:04 INFO - https://queue.taskcluster.net/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/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 14:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/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 14:52:05 INFO - Downloaded 22321318 bytes. 14:52:05 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'] 14:52:05 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 14:52:06 INFO - Return code: 0 14:52: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')]} 14:52:06 INFO - https://queue.taskcluster.net/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:52:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:52:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:52:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/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 14:52:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/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 14:52:08 INFO - Downloaded 10840152 bytes. 14:52:08 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'] 14:52:08 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 14:52:08 INFO - Return code: 0 14:52:08 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')]} 14:52:08 INFO - https://queue.taskcluster.net/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:52:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:52:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:52:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/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 14:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NeQSNznBQXe-s42Or1m5tQ/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 14:52:09 INFO - Downloaded 54835873 bytes. 14:52:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:52:09 INFO - mkdir: /builds/slave/test/properties 14:52:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:52:09 INFO - Writing to file /builds/slave/test/properties/build_url 14:52:09 INFO - Contents: 14:52:09 INFO - build_url:https://queue.taskcluster.net/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:52:10 INFO - Running post-action listener: _resource_record_post_action 14:52:10 INFO - Running post-action listener: set_extra_try_arguments 14:52:10 INFO - ##### 14:52:10 INFO - ##### Running populate-webroot step. 14:52:10 INFO - ##### 14:52:10 INFO - Running pre-action listener: _resource_record_pre_action 14:52:10 INFO - Running main action method: populate_webroot 14:52:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:52:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:52:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:52:10 INFO - '--tppagecycles', 14:52:10 INFO - '7'], 14:52:10 INFO - 'tests': ['tsvgm']}}, 14:52:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:52:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:52:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:52:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:52:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:52:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:52:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:10 INFO - 'talos_options': ['--disable-e10s'], 14:52:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:52:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:52:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:10 INFO - 'talos_options': ['--disable-e10s'], 14:52:10 INFO - 'tests': ['damp', 'tps']}, 14:52:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:10 INFO - 'tests': ['damp', 'tps']}, 14:52:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:52:10 INFO - 'tests': ['dromaeo_dom']}, 14:52:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:52:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:52:10 INFO - 'tests': ['a11yr', 14:52:10 INFO - 'ts_paint', 14:52:10 INFO - 'tpaint', 14:52:10 INFO - 'sessionrestore', 14:52:10 INFO - 'sessionrestore_no_auto_restore', 14:52:10 INFO - 'tabpaint']}, 14:52:10 INFO - 'other-e10s': {'tests': ['a11yr', 14:52:10 INFO - 'ts_paint', 14:52:10 INFO - 'tpaint', 14:52:10 INFO - 'sessionrestore', 14:52:10 INFO - 'sessionrestore_no_auto_restore', 14:52:10 INFO - 'tabpaint']}, 14:52:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:52:10 INFO - 'ts_paint', 14:52:10 INFO - 'tpaint', 14:52:10 INFO - 'sessionrestore', 14:52:10 INFO - 'sessionrestore_no_auto_restore', 14:52:10 INFO - 'tabpaint']}, 14:52:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:52:10 INFO - 'ts_paint', 14:52:10 INFO - 'tpaint', 14:52:10 INFO - 'sessionrestore', 14:52:10 INFO - 'sessionrestore_no_auto_restore', 14:52:10 INFO - 'tabpaint']}, 14:52:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:52:10 INFO - 'tests': ['a11yr', 14:52:10 INFO - 'ts_paint', 14:52:10 INFO - 'tpaint', 14:52:10 INFO - 'sessionrestore', 14:52:10 INFO - 'sessionrestore_no_auto_restore', 14:52:10 INFO - 'tabpaint']}, 14:52:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:52:10 INFO - 'tests': ['a11yr', 14:52:10 INFO - 'ts_paint', 14:52:10 INFO - 'tpaint', 14:52:10 INFO - 'sessionrestore', 14:52:10 INFO - 'sessionrestore_no_auto_restore', 14:52:10 INFO - 'tabpaint']}, 14:52:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:52:10 INFO - 'tests': ['tsvgx', 14:52:10 INFO - 'tsvgr_opacity', 14:52:10 INFO - 'tart', 14:52:10 INFO - 'tscrollx', 14:52:10 INFO - 'cart']}, 14:52:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:52:10 INFO - 'tsvgr_opacity', 14:52:10 INFO - 'tart', 14:52:10 INFO - 'tscrollx', 14:52:10 INFO - 'cart']}, 14:52:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:10 INFO - 'talos_options': ['--disable-e10s'], 14:52:10 INFO - 'tests': ['tp5o']}, 14:52:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:10 INFO - 'tests': ['tp5o']}, 14:52:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:10 INFO - 'talos_options': ['--disable-e10s', 14:52:10 INFO - '--xperf_path', 14:52:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:52:10 INFO - 'tests': ['tp5n']}, 14:52:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:10 INFO - 'talos_options': ['--xperf_path', 14:52:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:52:10 INFO - 'tests': ['tp5n']}}, 14:52:10 INFO - 'talos.zip': {'path': '', 14:52:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:52:10 INFO - Running post-action listener: _resource_record_post_action 14:52:10 INFO - ##### 14:52:10 INFO - ##### Running create-virtualenv step. 14:52:10 INFO - ##### 14:52:10 INFO - Running pre-action listener: _resource_record_pre_action 14:52:10 INFO - Running main action method: create_virtualenv 14:52:10 INFO - Creating virtualenv /builds/slave/test/build/venv 14:52:10 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 14:52:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:52:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:52:10 INFO - Using real prefix '/usr' 14:52:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:52:11 INFO - Installing distribute.............................................................................................................................................................................................done. 14:52:13 INFO - Installing pip.................done. 14:52:13 INFO - Return code: 0 14:52:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:52:13 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')]} 14:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:13 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')]} 14:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:13 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 0x7fc40c023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20307d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bf640>, '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 0x20c0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c09d0>, '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': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', '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 14:52:13 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 14:52:13 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 14:52:13 INFO - Using env: {'DISPLAY': ':0', 14:52:13 INFO - 'HOME': '/home/cltbld', 14:52:13 INFO - 'LANG': 'en_US.UTF-8', 14:52:13 INFO - 'LANGUAGE': 'en_US:en', 14:52:13 INFO - 'LOGNAME': 'cltbld', 14:52:13 INFO - 'MAIL': '/var/mail/cltbld', 14:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:13 INFO - 'MOZ_NO_REMOTE': '1', 14:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:13 INFO - 'NO_EM_RESTART': '1', 14:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:13 INFO - 'PWD': '/builds/slave/test', 14:52:13 INFO - 'SHELL': '/bin/bash', 14:52:13 INFO - 'SHLVL': '1', 14:52:13 INFO - 'TERM': 'linux', 14:52:13 INFO - 'TMOUT': '86400', 14:52:13 INFO - 'USER': 'cltbld', 14:52:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', 14:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:13 INFO - '_': '/tools/buildbot/bin/python'} 14:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:13 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 14:52:13 INFO - Cleaning up... 14:52:13 INFO - Return code: 0 14:52:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:52:13 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')]} 14:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:13 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')]} 14:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:13 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 0x7fc40c023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20307d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bf640>, '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 0x20c0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c09d0>, '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': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', '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 14:52:13 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 14:52:13 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 14:52:13 INFO - Using env: {'DISPLAY': ':0', 14:52:13 INFO - 'HOME': '/home/cltbld', 14:52:13 INFO - 'LANG': 'en_US.UTF-8', 14:52:13 INFO - 'LANGUAGE': 'en_US:en', 14:52:13 INFO - 'LOGNAME': 'cltbld', 14:52:13 INFO - 'MAIL': '/var/mail/cltbld', 14:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:13 INFO - 'MOZ_NO_REMOTE': '1', 14:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:13 INFO - 'NO_EM_RESTART': '1', 14:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:13 INFO - 'PWD': '/builds/slave/test', 14:52:13 INFO - 'SHELL': '/bin/bash', 14:52:13 INFO - 'SHLVL': '1', 14:52:13 INFO - 'TERM': 'linux', 14:52:13 INFO - 'TMOUT': '86400', 14:52:13 INFO - 'USER': 'cltbld', 14:52:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', 14:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:13 INFO - '_': '/tools/buildbot/bin/python'} 14:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:13 INFO - Downloading/unpacking psutil>=0.7.1 14:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:52:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:52:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:52:15 INFO - Installing collected packages: psutil 14:52:15 INFO - Running setup.py install for psutil 14:52:15 INFO - building 'psutil._psutil_linux' extension 14:52:15 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 14:52:15 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 14:52:15 INFO - building 'psutil._psutil_posix' extension 14:52:15 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 14:52:16 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 14:52:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:52:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:52:16 INFO - Successfully installed psutil 14:52:16 INFO - Cleaning up... 14:52:16 INFO - Return code: 0 14:52:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:52:16 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')]} 14:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:16 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')]} 14:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:16 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 0x7fc40c023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20307d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bf640>, '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 0x20c0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c09d0>, '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': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', '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 14:52:16 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 14:52:16 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 14:52:16 INFO - Using env: {'DISPLAY': ':0', 14:52:16 INFO - 'HOME': '/home/cltbld', 14:52:16 INFO - 'LANG': 'en_US.UTF-8', 14:52:16 INFO - 'LANGUAGE': 'en_US:en', 14:52:16 INFO - 'LOGNAME': 'cltbld', 14:52:16 INFO - 'MAIL': '/var/mail/cltbld', 14:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:16 INFO - 'MOZ_NO_REMOTE': '1', 14:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:16 INFO - 'NO_EM_RESTART': '1', 14:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:16 INFO - 'PWD': '/builds/slave/test', 14:52:16 INFO - 'SHELL': '/bin/bash', 14:52:16 INFO - 'SHLVL': '1', 14:52:16 INFO - 'TERM': 'linux', 14:52:16 INFO - 'TMOUT': '86400', 14:52:16 INFO - 'USER': 'cltbld', 14:52:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', 14:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:16 INFO - '_': '/tools/buildbot/bin/python'} 14:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:52:16 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 14:52:16 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 14:52:16 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 14:52:16 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 14:52:16 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 14:52:16 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 14:52:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:52:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:52:18 INFO - Installing collected packages: mozsystemmonitor 14:52:18 INFO - Running setup.py install for mozsystemmonitor 14:52:18 INFO - Successfully installed mozsystemmonitor 14:52:18 INFO - Cleaning up... 14:52:18 INFO - Return code: 0 14:52:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:18 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 0x7fc40c023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20307d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bf640>, '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 0x20c0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c09d0>, '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': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', '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 14:52:18 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 14:52:18 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 14:52:18 INFO - Using env: {'DISPLAY': ':0', 14:52:18 INFO - 'HOME': '/home/cltbld', 14:52:18 INFO - 'LANG': 'en_US.UTF-8', 14:52:18 INFO - 'LANGUAGE': 'en_US:en', 14:52:18 INFO - 'LOGNAME': 'cltbld', 14:52:18 INFO - 'MAIL': '/var/mail/cltbld', 14:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:18 INFO - 'MOZ_NO_REMOTE': '1', 14:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:18 INFO - 'NO_EM_RESTART': '1', 14:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:18 INFO - 'PWD': '/builds/slave/test', 14:52:18 INFO - 'SHELL': '/bin/bash', 14:52:18 INFO - 'SHLVL': '1', 14:52:18 INFO - 'TERM': 'linux', 14:52:18 INFO - 'TMOUT': '86400', 14:52:18 INFO - 'USER': 'cltbld', 14:52:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', 14:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:18 INFO - '_': '/tools/buildbot/bin/python'} 14:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:18 INFO - Downloading/unpacking blobuploader==1.2.4 14:52:18 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 14:52:18 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 14:52:18 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 14:52:18 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 14:52:18 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 14:52:18 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 14:52:20 INFO - Downloading blobuploader-1.2.4.tar.gz 14:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:52:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:52:20 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 14:52:20 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 14:52:20 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 14:52:20 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 14:52:20 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 14:52:20 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 14:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:52:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:52:21 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 14:52:21 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 14:52:21 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 14:52:21 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 14:52:21 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 14:52:21 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 14:52:21 INFO - Downloading docopt-0.6.1.tar.gz 14:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:52:21 INFO - Installing collected packages: blobuploader, requests, docopt 14:52:21 INFO - Running setup.py install for blobuploader 14:52:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:52:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:52:21 INFO - Running setup.py install for requests 14:52:21 INFO - Running setup.py install for docopt 14:52:21 INFO - Successfully installed blobuploader requests docopt 14:52:21 INFO - Cleaning up... 14:52:21 INFO - Return code: 0 14:52:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:21 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')]} 14:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:21 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')]} 14:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:21 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 0x7fc40c023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20307d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bf640>, '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 0x20c0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c09d0>, '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': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', '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 14:52:21 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 14:52:21 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 14:52:21 INFO - Using env: {'DISPLAY': ':0', 14:52:21 INFO - 'HOME': '/home/cltbld', 14:52:21 INFO - 'LANG': 'en_US.UTF-8', 14:52:21 INFO - 'LANGUAGE': 'en_US:en', 14:52:21 INFO - 'LOGNAME': 'cltbld', 14:52:21 INFO - 'MAIL': '/var/mail/cltbld', 14:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:21 INFO - 'MOZ_NO_REMOTE': '1', 14:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:21 INFO - 'NO_EM_RESTART': '1', 14:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:21 INFO - 'PWD': '/builds/slave/test', 14:52:21 INFO - 'SHELL': '/bin/bash', 14:52:21 INFO - 'SHLVL': '1', 14:52:21 INFO - 'TERM': 'linux', 14:52:21 INFO - 'TMOUT': '86400', 14:52:21 INFO - 'USER': 'cltbld', 14:52:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', 14:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:21 INFO - '_': '/tools/buildbot/bin/python'} 14:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:52:22 INFO - Running setup.py (path:/tmp/pip-wxeJ0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:52:22 INFO - Running setup.py (path:/tmp/pip-xtJt0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:52:22 INFO - Running setup.py (path:/tmp/pip-5iUYCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:52:22 INFO - Running setup.py (path:/tmp/pip-RLrotx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:52:22 INFO - Running setup.py (path:/tmp/pip-V0AvHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:52:22 INFO - Running setup.py (path:/tmp/pip-aOKcko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:52:22 INFO - Running setup.py (path:/tmp/pip-qCGT7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:52:22 INFO - Running setup.py (path:/tmp/pip-2Qh3vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:52:22 INFO - Running setup.py (path:/tmp/pip-qBKtlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:52:22 INFO - Running setup.py (path:/tmp/pip-JjXDr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:52:22 INFO - Running setup.py (path:/tmp/pip-e3KuG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:52:22 INFO - Running setup.py (path:/tmp/pip-pH73Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:52:23 INFO - Running setup.py (path:/tmp/pip-O9mTbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:52:23 INFO - Running setup.py (path:/tmp/pip-pJkatB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:23 INFO - Running setup.py (path:/tmp/pip-8VdCBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:52:23 INFO - Running setup.py (path:/tmp/pip-TyFKj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:52:23 INFO - Running setup.py (path:/tmp/pip-SkWVBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:52:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:52:23 INFO - Running setup.py install for manifestparser 14:52:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:52:23 INFO - Running setup.py install for mozcrash 14:52:23 INFO - Running setup.py install for mozdebug 14:52:23 INFO - Running setup.py install for mozdevice 14:52:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:52:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:52:23 INFO - Running setup.py install for mozfile 14:52:23 INFO - Running setup.py install for mozhttpd 14:52:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:52:23 INFO - Running setup.py install for mozinfo 14:52:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Running setup.py install for mozInstall 14:52:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Running setup.py install for mozleak 14:52:24 INFO - Running setup.py install for mozlog 14:52:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Running setup.py install for moznetwork 14:52:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Running setup.py install for mozprocess 14:52:24 INFO - Running setup.py install for mozprofile 14:52:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Running setup.py install for mozrunner 14:52:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:52:24 INFO - Running setup.py install for mozscreenshot 14:52:24 INFO - Running setup.py install for moztest 14:52:25 INFO - Running setup.py install for mozversion 14:52:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:52:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:52:25 INFO - Cleaning up... 14:52:25 INFO - Return code: 0 14:52:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52: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')]} 14:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52: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')]} 14:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:25 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 0x7fc40c023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20307d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bf640>, '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 0x20c0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c09d0>, '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': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', '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 14:52:25 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 14:52:25 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 14:52:25 INFO - Using env: {'DISPLAY': ':0', 14:52:25 INFO - 'HOME': '/home/cltbld', 14:52:25 INFO - 'LANG': 'en_US.UTF-8', 14:52:25 INFO - 'LANGUAGE': 'en_US:en', 14:52:25 INFO - 'LOGNAME': 'cltbld', 14:52:25 INFO - 'MAIL': '/var/mail/cltbld', 14:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:25 INFO - 'MOZ_NO_REMOTE': '1', 14:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:25 INFO - 'NO_EM_RESTART': '1', 14:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:25 INFO - 'PWD': '/builds/slave/test', 14:52:25 INFO - 'SHELL': '/bin/bash', 14:52:25 INFO - 'SHLVL': '1', 14:52:25 INFO - 'TERM': 'linux', 14:52:25 INFO - 'TMOUT': '86400', 14:52:25 INFO - 'USER': 'cltbld', 14:52:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', 14:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:25 INFO - '_': '/tools/buildbot/bin/python'} 14:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:52:25 INFO - Running setup.py (path:/tmp/pip-XmbYdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:52:25 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)) 14:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:52:25 INFO - Running setup.py (path:/tmp/pip-xgrB37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:52:25 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)) 14:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:52:25 INFO - Running setup.py (path:/tmp/pip-YVLpXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:52:25 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)) 14:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:52:25 INFO - Running setup.py (path:/tmp/pip-OWWIiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:52:25 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)) 14:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:52:25 INFO - Running setup.py (path:/tmp/pip-uGgBlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:52:25 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)) 14:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:52:25 INFO - Running setup.py (path:/tmp/pip-mxCwZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:52:25 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)) 14:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:52:25 INFO - Running setup.py (path:/tmp/pip-cufizb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:52:25 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)) 14:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:52:25 INFO - Running setup.py (path:/tmp/pip-X18cgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:52:25 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)) 14:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:52:25 INFO - Running setup.py (path:/tmp/pip-EcyaLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:52:26 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)) 14:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:52:26 INFO - Running setup.py (path:/tmp/pip-ipqI2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:52:26 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)) 14:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:52:26 INFO - Running setup.py (path:/tmp/pip-HBEyoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:52:26 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)) 14:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:52:26 INFO - Running setup.py (path:/tmp/pip-IP926d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:52:26 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)) 14:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:52:26 INFO - Running setup.py (path:/tmp/pip-eFkCV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:52:26 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)) 14:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:52:26 INFO - Running setup.py (path:/tmp/pip-Era72e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:52:26 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)) 14:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:26 INFO - Running setup.py (path:/tmp/pip-rWx21R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:26 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)) 14:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:52:26 INFO - Running setup.py (path:/tmp/pip-6Oqc8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:52:26 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)) 14:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:52:26 INFO - Running setup.py (path:/tmp/pip-LgppXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:52:26 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)) 14:52:26 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)) 14:52:26 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)) 14:52:26 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)) 14:52:26 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)) 14:52:26 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)) 14:52:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:52:26 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 14:52:26 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 14:52:26 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 14:52:26 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 14:52:26 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 14:52:26 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 14:52:28 INFO - Downloading blessings-1.6.tar.gz 14:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:52:28 INFO - Installing collected packages: blessings 14:52:28 INFO - Running setup.py install for blessings 14:52:28 INFO - Successfully installed blessings 14:52:28 INFO - Cleaning up... 14:52:28 INFO - Return code: 0 14:52:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:52:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:52:28 INFO - Reading from file tmpfile_stdout 14:52:28 INFO - Current package versions: 14:52:28 INFO - argparse == 1.2.1 14:52:28 INFO - blessings == 1.6 14:52:28 INFO - blobuploader == 1.2.4 14:52:28 INFO - docopt == 0.6.1 14:52:28 INFO - manifestparser == 1.1 14:52:28 INFO - mozInstall == 1.12 14:52:28 INFO - mozcrash == 0.17 14:52:28 INFO - mozdebug == 0.1 14:52:28 INFO - mozdevice == 0.48 14:52:28 INFO - mozfile == 1.2 14:52:28 INFO - mozhttpd == 0.7 14:52:28 INFO - mozinfo == 0.9 14:52:28 INFO - mozleak == 0.1 14:52:28 INFO - mozlog == 3.1 14:52:28 INFO - moznetwork == 0.27 14:52:28 INFO - mozprocess == 0.22 14:52:28 INFO - mozprofile == 0.28 14:52:28 INFO - mozrunner == 6.11 14:52:28 INFO - mozscreenshot == 0.1 14:52:28 INFO - mozsystemmonitor == 0.0 14:52:28 INFO - moztest == 0.7 14:52:28 INFO - mozversion == 1.4 14:52:28 INFO - psutil == 3.1.1 14:52:28 INFO - requests == 1.2.3 14:52:28 INFO - wsgiref == 0.1.2 14:52:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:28 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 0x7fc40c023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20307d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bf640>, '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 0x20c0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c09d0>, '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': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', '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 14:52:28 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 14:52:28 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 14:52:28 INFO - Using env: {'DISPLAY': ':0', 14:52:28 INFO - 'HOME': '/home/cltbld', 14:52:28 INFO - 'LANG': 'en_US.UTF-8', 14:52:28 INFO - 'LANGUAGE': 'en_US:en', 14:52:28 INFO - 'LOGNAME': 'cltbld', 14:52:28 INFO - 'MAIL': '/var/mail/cltbld', 14:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:28 INFO - 'MOZ_NO_REMOTE': '1', 14:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:28 INFO - 'NO_EM_RESTART': '1', 14:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:28 INFO - 'PWD': '/builds/slave/test', 14:52:28 INFO - 'SHELL': '/bin/bash', 14:52:28 INFO - 'SHLVL': '1', 14:52:28 INFO - 'TERM': 'linux', 14:52:28 INFO - 'TMOUT': '86400', 14:52:28 INFO - 'USER': 'cltbld', 14:52:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', 14:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:28 INFO - '_': '/tools/buildbot/bin/python'} 14:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:29 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)) 14:52:29 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)) 14:52:29 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)) 14:52:29 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)) 14:52:29 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)) 14:52:29 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)) 14:52:29 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)) 14:52:29 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)) 14:52:29 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)) 14:52:29 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)) 14:52:29 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)) 14:52:29 INFO - Cleaning up... 14:52:29 INFO - Return code: 0 14:52:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:29 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 0x7fc40c023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20307d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bf640>, '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 0x20c0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c09d0>, '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': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', '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 14:52:29 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 14:52:29 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 14:52:29 INFO - Using env: {'DISPLAY': ':0', 14:52:29 INFO - 'HOME': '/home/cltbld', 14:52:29 INFO - 'LANG': 'en_US.UTF-8', 14:52:29 INFO - 'LANGUAGE': 'en_US:en', 14:52:29 INFO - 'LOGNAME': 'cltbld', 14:52:29 INFO - 'MAIL': '/var/mail/cltbld', 14:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:29 INFO - 'MOZ_NO_REMOTE': '1', 14:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:29 INFO - 'NO_EM_RESTART': '1', 14:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:29 INFO - 'PWD': '/builds/slave/test', 14:52:29 INFO - 'SHELL': '/bin/bash', 14:52:29 INFO - 'SHLVL': '1', 14:52:29 INFO - 'TERM': 'linux', 14:52:29 INFO - 'TMOUT': '86400', 14:52:29 INFO - 'USER': 'cltbld', 14:52:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', 14:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:29 INFO - '_': '/tools/buildbot/bin/python'} 14:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:29 INFO - Downloading/unpacking jsonschema 14:52:29 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 14:52:29 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 14:52:29 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 14:52:29 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 14:52:29 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 14:52:29 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 14:52:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:52:31 INFO - Downloading/unpacking functools32 (from jsonschema) 14:52:31 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 14:52:31 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 14:52:31 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 14:52:31 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 14:52:31 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 14:52:31 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 14:52:31 INFO - Downloading functools32-3.2.3-2.tar.gz 14:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:52:31 INFO - warning: no files found matching '*.txt' 14:52:31 INFO - no previously-included directories found matching 'build' 14:52:31 INFO - no previously-included directories found matching 'dist' 14:52:31 INFO - no previously-included directories found matching '.git*' 14:52:31 INFO - Installing collected packages: jsonschema, functools32 14:52:31 INFO - Running setup.py install for functools32 14:52:31 INFO - warning: no files found matching '*.txt' 14:52:31 INFO - no previously-included directories found matching 'build' 14:52:31 INFO - no previously-included directories found matching 'dist' 14:52:31 INFO - no previously-included directories found matching '.git*' 14:52:31 INFO - Successfully installed jsonschema functools32 14:52:31 INFO - Cleaning up... 14:52:31 INFO - Return code: 0 14:52:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:52:31 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')]} 14:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:31 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')]} 14:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:31 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 0x7fc40c023f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20307d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bf640>, '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 0x20c0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c09d0>, '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': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', '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 14:52:31 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 14:52:31 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 14:52:31 INFO - Using env: {'DISPLAY': ':0', 14:52:31 INFO - 'HOME': '/home/cltbld', 14:52:31 INFO - 'LANG': 'en_US.UTF-8', 14:52:31 INFO - 'LANGUAGE': 'en_US:en', 14:52:31 INFO - 'LOGNAME': 'cltbld', 14:52:31 INFO - 'MAIL': '/var/mail/cltbld', 14:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:31 INFO - 'MOZ_NO_REMOTE': '1', 14:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:31 INFO - 'NO_EM_RESTART': '1', 14:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:31 INFO - 'PWD': '/builds/slave/test', 14:52:31 INFO - 'SHELL': '/bin/bash', 14:52:31 INFO - 'SHLVL': '1', 14:52:31 INFO - 'TERM': 'linux', 14:52:31 INFO - 'TMOUT': '86400', 14:52:31 INFO - 'USER': 'cltbld', 14:52:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', 14:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:31 INFO - '_': '/tools/buildbot/bin/python'} 14:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:31 INFO - Downloading/unpacking flake8 14:52:31 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 14:52:31 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 14:52:31 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 14:52:31 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 14:52:31 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 14:52:31 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 14:52:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:52:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:52:33 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 14:52:33 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 14:52:33 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 14:52:33 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 14:52:33 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 14:52:33 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 14:52:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:52:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:52:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:52:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:52:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:52:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:52:34 INFO - no previously-included directories found matching 'docs/_build' 14:52:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:52:34 INFO - Running setup.py install for pep8 14:52:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:52:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:52:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:52:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:52:34 INFO - no previously-included directories found matching 'docs/_build' 14:52:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:52:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:52:34 INFO - Cleaning up... 14:52:34 INFO - Return code: 0 14:52:34 INFO - Running post-action listener: _resource_record_post_action 14:52:34 INFO - Running post-action listener: _start_resource_monitoring 14:52:34 INFO - Starting resource monitoring. 14:52:34 INFO - ##### 14:52:34 INFO - ##### Running install step. 14:52:34 INFO - ##### 14:52:34 INFO - Running pre-action listener: _resource_record_pre_action 14:52:34 INFO - Running main action method: install 14:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:52:35 INFO - Reading from file tmpfile_stdout 14:52:35 INFO - Detecting whether we're running mozinstall >=1.0... 14:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:52:35 INFO - Reading from file tmpfile_stdout 14:52:35 INFO - Output received: 14:52:35 INFO - Usage: mozinstall [options] installer 14:52:35 INFO - Options: 14:52:35 INFO - -h, --help show this help message and exit 14:52:35 INFO - -d DEST, --destination=DEST 14:52:35 INFO - Directory to install application into. [default: 14:52:35 INFO - "/builds/slave/test"] 14:52:35 INFO - --app=APP Application being installed. [default: firefox] 14:52:35 INFO - mkdir: /builds/slave/test/build/application 14:52:35 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'] 14:52:35 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 14:52:50 INFO - Reading from file tmpfile_stdout 14:52:50 INFO - Output received: 14:52:50 INFO - /builds/slave/test/build/application/firefox/firefox 14:52:50 INFO - Running post-action listener: _resource_record_post_action 14:52:50 INFO - ##### 14:52:50 INFO - ##### Running run-tests step. 14:52:50 INFO - ##### 14:52:50 INFO - Running pre-action listener: _resource_record_pre_action 14:52:50 INFO - Running main action method: run_tests 14:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:52:50 INFO - Python 2.7.3 14:52:50 INFO - Return code: 0 14:52:50 INFO - grabbing minidump binary from tooltool 14:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:50 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 0x20bf640>, '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 0x20c0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c09d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:52:50 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 14:52:50 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 14:52:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:52:50 INFO - Return code: 0 14:52:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:52:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:52:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:52:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:52:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:52:51 INFO - Return code: 0 14:52:51 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/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 14:52:51 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/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 14:52:51 INFO - Using env: {'DISPLAY': ':0', 14:52:51 INFO - 'HOME': '/home/cltbld', 14:52:51 INFO - 'LANG': 'en_US.UTF-8', 14:52:51 INFO - 'LANGUAGE': 'en_US:en', 14:52:51 INFO - 'LOGNAME': 'cltbld', 14:52:51 INFO - 'MAIL': '/var/mail/cltbld', 14:52:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:52:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:51 INFO - 'MOZ_NO_REMOTE': '1', 14:52:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:51 INFO - 'NO_EM_RESTART': '1', 14:52:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:51 INFO - 'PWD': '/builds/slave/test', 14:52:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:52:51 INFO - 'SHELL': '/bin/bash', 14:52:51 INFO - 'SHLVL': '1', 14:52:51 INFO - 'TERM': 'linux', 14:52:51 INFO - 'TMOUT': '86400', 14:52:51 INFO - 'USER': 'cltbld', 14:52:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198', 14:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:51 INFO - '_': '/tools/buildbot/bin/python'} 14:52:51 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/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 14:52:52 INFO - mozversion application_buildid: 20160505142107 14:52:52 INFO - mozversion application_changeset: daa53f98b541117b380d848f34eb00570ae71d2b 14:52:52 INFO - mozversion application_display_name: Nightly 14:52:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:52:52 INFO - mozversion application_name: Firefox 14:52:52 INFO - mozversion application_remotingname: firefox 14:52:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:52:52 INFO - mozversion application_vendor: Mozilla 14:52:52 INFO - mozversion application_version: 49.0a1 14:52:52 INFO - mozversion platform_buildid: 20160505142107 14:52:52 INFO - mozversion platform_changeset: daa53f98b541117b380d848f34eb00570ae71d2b 14:52:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:52:52 INFO - mozversion platform_version: 49.0a1 14:52:52 INFO - using testdate: 1462485172 14:52:52 INFO - actual date: 1462485172 14:52:52 INFO - starting webserver on 'localhost:33554' 14:52:52 INFO - SUITE-START | Running 2 tests 14:52:52 INFO - TEST-START | dromaeo_css 14:52:52 INFO - operating with platform_type : linux_ 14:52:52 INFO - Initialising browser for dromaeo_css test... 14:52:52 INFO - TEST-INFO | started process 19592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuNbzzL/profile http://localhost:33554/getInfo.html) 14:52:56 INFO - PROCESS | 19592 | __metrics Screen width/height:1600/1200 14:52:56 INFO - PROCESS | 19592 | colorDepth:24 14:52:56 INFO - PROCESS | 19592 | Browser inner width/height: 1024/697 14:52:56 INFO - PROCESS | 19592 | __metrics 14:52:57 ERROR - PROCESS | 19592 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:52:58 INFO - TEST-INFO | 19592: exit 0 14:52:58 INFO - Browser initialized. 14:52:58 INFO - Running cycle 1/1 for dromaeo_css test... 14:52:58 INFO - TEST-INFO | started process 19674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuNbzzL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:53:10 INFO - PROCESS | 19674 | RSS: Main: 153833472 14:53:10 INFO - PROCESS | 19674 | 14:54:02 INFO - PROCESS | 19674 | 1462485242252 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] 14:56:13 INFO - PROCESS | 19674 | Cycle 1(1): loaded http://localhost:33554/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33554/tests/dromaeo/cssquery-ext.html) 14:56:14 INFO - PROCESS | 19674 | RSS: Main: 269873152 14:56:14 INFO - PROCESS | 19674 | 14:59:17 INFO - PROCESS | 19674 | Cycle 1(1): loaded http://localhost:33554/tests/dromaeo/cssquery-ext.html (next: http://localhost:33554/tests/dromaeo/cssquery-jquery.html) 14:59:18 INFO - PROCESS | 19674 | RSS: Main: 244031488 14:59:18 INFO - PROCESS | 19674 | 15:02:20 INFO - PROCESS | 19674 | Cycle 1(1): loaded http://localhost:33554/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33554/tests/dromaeo/cssquery-mootools.html) 15:02:21 INFO - PROCESS | 19674 | RSS: Main: 241713152 15:02:21 INFO - PROCESS | 19674 | 15:05:23 INFO - PROCESS | 19674 | Cycle 1(1): loaded http://localhost:33554/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33554/tests/dromaeo/cssquery-prototype.html) 15:05:23 INFO - PROCESS | 19674 | RSS: Main: 237875200 15:05:23 INFO - PROCESS | 19674 | 15:08:26 INFO - PROCESS | 19674 | Cycle 1(1): loaded http://localhost:33554/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33554/tests/dromaeo/cssquery-yui.html) 15:08:27 INFO - PROCESS | 19674 | RSS: Main: 200863744 15:08:27 INFO - PROCESS | 19674 | 15:11:30 INFO - PROCESS | 19674 | Cycle 1(1): loaded http://localhost:33554/tests/dromaeo/cssquery-yui.html (next: http://localhost:33554/tests/dromaeo/cssquery-dojo.html) 15:11:30 INFO - PROCESS | 19674 | RSS: Main: 322228224 15:11:30 INFO - PROCESS | 19674 | 15:11:30 INFO - PROCESS | 19674 | __start_tp_report 15:11:30 INFO - PROCESS | 19674 | _x_x_mozilla_page_load 15:11:30 INFO - PROCESS | 19674 | _x_x_mozilla_page_load_details 15:11:30 INFO - PROCESS | 19674 | |i|pagename|runs| 15:11:30 INFO - PROCESS | 19674 | |0;dojo.html;2681.8793154308055;2687.9596806047907;2721.9047333343337;2753.834769913804;2762.7651649609784;4659.3709849170355;4695.17834378984;4749.073930583538;4778.474367819542;4836.540528649777;4686.109639168556;4695.788689508971;4766.809327626891;4839.75801209939;4864.294677271793;4302.978485107586;4328.826846926135;4377.212101821671;4403.141387429437;4548.49966503686;4483.663725220606;4497.550244975492;4502.639788816887;4545.863624091283;4549.044700612875;4299.118680670455;4312.22379971605;4342.370356298319;4362.127574485084;4376.387305777193;4279.957200428018;4299.677524185668;4302.440682711259;4426.203283408985;4435.201663700533;4367.45406824147;4369.3227549729845;4378.1462614790125;4414.3157810539415;4417.182821178092;4523.095380923828;4582.450105987269;4669.1828929937465;4712.95287047132;4727.881802954954;5082.339295891547;5174.275601415768;5175;5178.223266510016;5180.585553155738;5139;5145.536901678867;5160.458151894072;5202.271681964528;5207.0366982108435;4628.745419001987;4714.127886341038;4746.121967436035;4790.993891282835;4846.273059041172;5217.3999990000875;5232.136697444955;5277.261183434322;5283.1546952487415;5292.285541451932;5023.045621331935;5043.445221025684;5089.491050894955;5092.567131793839;5094.439611642716;4963.553280204799;5009.874753131128;5044.596432285409;5047.268146118792;5116.769745361467;5007.123753343223;5033.144365457808;5034.421041580265;5035.496450354935;5081.110805609003;4982.227754698028;4997.100521906019;4998.475160108209;5003.649744517848;5044.495550444926;4274.679399045084;4375.321825117112;4391.099824536026;4430.047539778963;4437.356583295468;3835.0412396900774;3847.3844184930836;3849.4225866120305;3887.028242939265;3908.6677632401565;4444.2222611042935;4459.576340247671;4461.709988850779;4493.168763778712;4506.121306345297;4960.627952903546;5105.719185444762;5158.071547121479;5161.767720452589;5214.556762675139;4414.690971632019;4434.201843668171;4439.755813430228;4442.267025940748;4486.327050942385;4684.648651351163;4697.037107392976;4699.906001879944;4702.52974702527;4741.5495527924795;4703.858884233478;4814.253790662453;4845.927311090407;4875.341828853059;4890.021995600823;5120.385553733576;5127.3847138343635;5128.6153538485505;5142.17725163987;5197.038547868505;4630.76846157684;4826.903461930812;4843.4430040545785;4845.927311090407;4895.755212239303;5035.471275516018;5047.646664733434;5061.6962982221185;5104.464031276811;5111.616628752784;5137.845864624067;5152.407473140487;5156.716380598953;5166.2508936204795;5207.531322181022;4864.610831133572;4971.9005619886675;4998.175301075282;5004.3494345734825;5007.7746501408255;4995.725235111959;5030.0191462664425;5053.949460505348;5094.133997220407;5099.6685215460875;4938.703677779345;4981.028699403581;5008.549230569266;5020.297158397901;5027.271045698426;4832.299316599003;4928.383952005999;5064.924026139684;5100.846974590768;5123.949590334048;4868.123737727243;4895.681780684244;4912.435069966999;4916.582090522203;4962.900741985068 15:11:30 INFO - PROCESS | 19674 | |1;ext.html;551.5229326632464;595.9702014899254;606.8348770360909;607.2470137030084;609.0620444515447;41324.38013429797;42860;42942.785286073566;42982.355264671016;46758.53241467593;41248;41776;41849.16301673964;41951.16097678052;42051.36922946158;7862.803429914241;7991.24083212094;8000.199980002011;8003.399745019117;8008.719694810683;7824.921750782476;7979.241972012649;7982.521048737065;7986.480878742892;7987.760367188994;7970.920290797076;8023.558704271263;8023.839523209533;8023.879641805348;8026.558539280337;7960;7960.323372513343;7962.283394494465;7969.402294827853;7989.121196668362;7818.061832580127;7892.329152022085;7892.881606775903;7901.130875603679;7905.960470197612;38745.806270968744;39001.219975600616;39079.60920390788;39210.41184382237;39246.803765981276;3128.7809853310278;3373.6457671944336;3468.791872487659;3491.30173965208;3744.475773391727;29328.266793330124;29700;29746.85126574375;30187.547186792217;30949;2939.6913324100874;2943.417888142204;2960.8963686270877;2994.4160888626725;3026.6973302669558;184313;184937;184953;185032;185190;46911.5308846914;54071.18893216605;54426.45573544214;58968.80827513135;60702.08946865801;58370;58613.41386586165;58646;58695.413045869;58781.70609146927;15374.385024599114;15500.689986200212;15524.14617196065;15527.068375897255;15534.611634709223;9998.600055997678;10296.794064118825;10296.948515257376;11884.702882427835;12088.576899808464;15739.921300393426;16120.919395403182;16228.971378577678;16365.672686546202;16475.91762041206;6507.7071531781185;6554.672266386661;6583.80248592543;6594.8351291218105;6694.330566943364;834.8330333933237;911.2300106410073;983.8509316770186;1052.905238528536;1100.5982816272003;28591.14226573206;29009.274768130967;29278.560821587693;29589.408211835642;29613.111606651833;987.5802783816849;1036.2694300518117;1043.2853495355555;1070.9518071686794;1130.3331034689409;15227.771583426258;15471.381144754083;15636.843631563539;15683.451079212173;15911.761323580156;346881;349833;349994;350335;352120;51137.48862511402;52277.647505862325;52332.73833630807;52460.73769631204;52463.213051804254;1146.220570012383;1256.8428946381703;1281.6027031620042;1313.4549162097621;1323.4243104249683;27142.457150856477;30139.09582712522;30563.388732225674;30776.69223307738;30996.53505197469;44954.55045449635;45804.31293530666;45834.85412864572;45910;45919.77040114778;314198;318794;320311;321120;321466;32950;41331.380029300184;41395.58604414038;43491.56508435002;44777;43877.12245755131;44030.779846100566;44596.77701611471;44786.55213447824;45028.77485612682;36180;36873;37141.257174856895;37643.2471350566;38315.2336953265;36981.63018369782;37095;37311.81344093262;37396;37483.625163748016;32428.35143297168;32608.673913260565;32914.34171316608;37304.44043339298;37309;32202.83898580492;33907.15232119217;34148.82925585356;34209.31581368309;34290.82854585711;25862.61206081948;26397.20808375752;26496.735032649427;26591.601125983514;26632.201033969013 15:11:30 INFO - PROCESS | 19674 | |2;jquery.html;372.9794861282629;374.20108069272106;377.311406682804;382.60591590661596;385.0354861073013;16189.271482783273;17670.116494175305;17877.642447151065;17959.281628734836;18317.358892438784;15066.3220155093;15879.60300992473;15992.440264590741;16025.35898564056;16033.518994430186;5017.7240251786225;5167.302414174094;5193.870153246161;5197.818076367328;5200.6619569727845;3637.381645120336;5151.278820965068;5573.052581061209;5850.707464626752;5855.033919403293;5887.116932460122;5894.292684877799;5917.260342457193;5919.644821310713;5922.111683247525;5727.570432217601;5833.241678581779;5888.38171991939;5906.970465147669;5914.231149950522;3336.799792012487;4853.9029219415415;5155.123628983082;5181.4559471255725;5196.948030519684;20432.080556375;20980.79019209819;21012.684809727867;21339.893300533553;21349.466263343384;1983.2959299448776;2112.598606264805;2130.43543460983;2355.9764402355927;2550.3624093976505;12490.813372729666;13041.152325098838;13141.86858131416;13358.265295408748;13547.119437236548;1694.4323651576738;1721.8106008339073;1780.1188411736273;1787.6245988342334;1830.6979348407497;68094.53101955306;68105;68580.3141968584;69229.65385173092;70729.64635176791;9131.360804743737;9235.76910577241;9647.228221742243;9649.758756031155;9679.806403871884;13375.53185638498;13459.192448453125;13476.258805765581;13486.258255796025;13496.717811807863;7325.450591205681;7383.667734951832;7383.963080184672;7484.550926944401;7532.623368831537;7148.17795953472;7165.283471652897;7192;7270.818229544304;7272.49092563526;6119.877602448015;6238.968805156036;6254.499640028786;6281.340459251713;6358.968205158944;1627.1294857251314;1707.4109432246103;1777.1380880273057;1799.2892807341027;1811.7010693235468;883.6156272021562;932.9626814927462;952.3190918493173;1015.2892974917587;1038.4755698372273;17057.402990895258;17232;17282.308707651555;17680.29278828858;17768.822311776716;881;903.6114470777628;943.1370296179057;976.1751320134475;980.3823591137538;9915.851262231072;9916.4545949972;10125.898741012643;10147.64483243083;10182.439965801805;367979;369610;370152;372079;375011;68179;70335.64832175909;70778.64610676914;70880.2911970884;71944.28055719376;963.2294164668237;992.2954702161402;1019.5157300282307;1024.073213741565;1029.891861354547;15729.370825166865;15943.920280398524;16017;16031;16493.257803398636;32197.51703724493;32489.35021299608;32872.83563582167;33555.328893422484;37154;38771.41842872416;45584;47059.29411058768;48630.27054594255;49002.64730956577;7346.4122870169185;7610.277023682741;7657.540547566941;7748.57382843949;7757.7672669819995;11582.6525204244;11612.361320127475;11777.823332649845;11867.525298987945;12087.939560302493;9665.516724163623;10257.948710256402;10305.845412318971;10309.381437113798;10578.735531611772;10252.077313041862;10278.743031424274;10289.43408112561;10521.526531305957;10619.469026548797;10171.593136274467;10446.529906154394;10504.054635082879;10525.36847789135;10721.463926803784;7361.8159546011775;7368.889466657897;7439.9256007439235;7554.2823431773895;7619.733309334147;9024.864627030469;9849.507524623883;9929.602815887283;9997.150242229493;10017.14854237398 15:11:30 INFO - PROCESS | 19674 | |3;mootools.html;1284.0690499387938;1511.9622009449765;1520.2170881995771;1711.5721069732567;1850.8704390692649;6607.636579988099;7391.630418479074;7590.316871481566;7606.125295591002;7791;7312.524685895413;7451.478396512246;7453.105627324715;7461.141968673591;7476.065491813523;2191.8356123290737;2206.360155554887;2214.2360885494477;2216.0803266644402;2216.9556608867815;2148.7851214878465;2164.945876353096;2170.8046275835172;2172.587208430401;2181.203860590881;2140.892955352234;2148.291063948893;2157.7302837145357;2157.7626461089267;2189.737231532218;2097.64340062189;2099.191811152717;2103.852730308879;2104.4633618427356;2107.3677896630948;2102.4743814046487;2154.9892250538805;2155.3426205007468;2158.298552970291;2159.1147629471843;7421.369183619398;7537.397008239328;7597.772066838003;7654.19630938749;7683.57740324282;4528.456585209763;4633.976830115827;4662.883427914329;4663.953360466386;4677.672562920597;2800.957985630217;2817.1548535439492;2856.471552762725;2877.928051798701;2941.6322959630047;892.076700614867;919.4161707315835;923.1599244687369;945.163530275711;949.9145076943108;10295.279330446872;10427.426491542961;10432.895671043269;10438.112760415373;10457.947710261476;3775.6035616260447;3889.105505733697;3940.1725637616423;3940.2907476653904;4022.5374081980362;8289.0467596226;8336.874946875801;8349;8358.958205208935;8371.832563348698;4472.239719247671;4475.01549659081;4485.910281794346;4497.8425755098415;4502.977485112553;3558.288342331544;4049.493813273341;4050.4531888195306;4118.691098167589;4190.371444283382;3424.931501369959;3473.5484387029524;3530.3998320285614;3558.395072837624;3580.0870777951977;1029.9639512617023;1057.841323801436;1071.45891324882;1079.0342643334172;1079.0396547073112;859.7893516088599;870.3081050564816;871.9346049046347;883.4787475389551;893.3433926064338;5176.870578235575;5179.870503237374;5235.476452354734;5263.36839579253;5296.1261391870685;851.1275942159336;897.7261935109855;922.4695799915075;927.939683920543;944.6599224279254;3583.8028908409765;3628.9455658165148;3646.106703857519;3664.13892735207;3728.813559322023;9117.498537580497;9360.204382627417;9554.617815287449;9556;9573.808523829624;9243.029481904437;9330.720078397659;9455.810883782286;9457.38526995743;9499.572519236652;6962.930370696228;7004.474664400191;7089.432845372357;7098.36114749675;7109.1824440189;5112.437631860418;5177.508136727005;5241.947580524298;5309.681419114711;5428.077226871363;8487.618057187565;8732.99570549395;8855.911440885766;8926.196642301964;8959.1936725695;8856.64573417082;8870.983726784241;8964.193222609736;8983.820323593362;8988.730338089868;5735.225744524436;5964.254468191476;6090;6249.156363890998;6442.387973142544;7195.02867112933;7239.167495737847;7279.162896266997;7292.124945006633;7294.2341054190665;6467.191601049869;6647.800565983028;6669.866602668017;6730.798076057726;6836.350546698056;6611.603303801788;6617.867642647024;6634.303398143318;6655.966720166368;6707.966460167668;6282.434580887742;6338.65137417428;6348.079528468438;6349.4920406366455;6356.491480681627;4551.977240113778;4614.838480653161;4704.835330763407;4786.856394308176;4811.302361157683;4754.19178739622;4833.226683730727;4857.295692124551;4894.730789806595;4934.407871055353 15:11:30 INFO - PROCESS | 19674 | |4;prototype.html;289.1441333652389;291.9401522687849;295.5788002097011;296.19287441721315;297.9985100074499;4625.653076019299;4640.095181439612;4651.302304654304;4694.953050469494;4695.67130300879;4635.837745678902;4648.907021859569;4655.045715628296;4655.860324190271;4659.510751371108;3491.266833964864;3597.1366871950804;3623.3296840084668;3693.1874987502706;3707.4994875691705;3659.213269147133;3680.963190368089;3697.8335974881193;3733.9253214935684;3740.775553466787;3497.5977762557377;3661.7802931824044;3682.0426689060905;3692.48305237267;3698.2802996606574;3595.173110184659;3665.963340366602;3676.3382591133586;3694.11341278094;3713.20166164276;3278.1804548862783;3289.3914625794305;3290.835458227079;3303.4714445688815;3309.5603412515634;4427.225235583792;4459.487158976727;4469.882529367658;4476.261416866213;4506.909861802746;3933.7836418996944;4169.770662613555;4171;4178.519470260929;4191.97904010481;4847.345608342864;4856.15017371962;4873.926891096637;4881.072596206709;4900.603328051524;3489.94765078524;3504.281622267429;3507.158282012324;3507.824608769551;3523.7885726856216;4964.702117872903;5007.574356179765;5053.620978426596;5090.38915330159;5093.312402825608;3576.338377400189;3591.3356029134693;3594.1733401317842;3598.784072955631;3606.6573675500786;3633.5276414066;3638.636136386393;3645.343838109166;3646.556806939357;3650.3064417760543;4124.7731374774075;4130.91738165235;4132.876013719593;4138.151678905817;4140.171965606891;4677.18149323867;4864.513548645107;4880.389951256093;4882.658213924991;4892.217245240744;1184.8163534652142;1189.143816452153;1191.2078467818976;1195.0857593940643;1204.5904392506416;781.9609019549;823.8105235795681;834.3408707121306;840.2479780596454;842.8862103615934;4154.31453810124;4159.792010399528;4163.812628431728;4168.374743788456;4176.707630465899;4722.9137298420865;4769.451513076041;4803.3995750531185;4813.542713442217;4859.743971539077;4020.6984476164403;4143.845200495725;4168.416421700964;4198.71170212235;4214.852480163179;2550.4644024755007;2550.91586075917;2565.666463359751;2571.3057474481784;2572.215474280325;4576.702514336557;4584.289435137559;4596.5863072323655;4602.585767280961;4607.562281583244;4631.768411579407;4900.30939325932;4904.681195722266;4915.3855768029;4952.653314268039;4581.610563102107;4590.403247577793;4593;4606.792694328763;4609.539046095364;4754.286856971482;4787.640926930564;4798.7840547174765;4800;4800.279958006327;4560.195479779845;4735.384400027974;4740;4758.333833263277;4759.119562880878;4446.755428451466;4548.74981876;4583.289590113538;4593.26507758757;4593.724376537285;3445.517627532198;3446.052335607628;3460.7231421486727;3487.3897068013503;3487.6163622001054;4750.197383543726;4754.096721622881;4768.833090841804;4789.688670236424;4797.856064318076;4439.711418757771;4604.815807367801;4608.930866037079;4652.557707110806;4687.5781179693995;4659.254519276899;4673.602743766682;4674.345591617244;4676.877549388054;4685.6017238535105;4552.52198519164;4560.335477550737;4590.35734997094;4608.976955115203;4631.374764406762;4573.519780423007;4661.394018777537;4689.835855745033;4728.456227533878;4872.757446851172;4777.784999675093;4813.302071199727;4822.38450119214;4834.63740219492;4855.295982082507 15:11:30 INFO - PROCESS | 19674 | |5;yui.html;734.0823970037453;762.2225330163234;762.2567996203701;794.9761507154785;838.2832678060258;11434.42827858608;11468.139889508278;11557.768844623102;11558.075353971682;11594.304341739502;11881.227720198181;11909.106816988717;11932.284062956229;11956.880431195685;11966.162368634199;681.7613835157705;858.7423772868145;868.0538213347465;887.7691800131947;891.5453118909338;876.662484943295;878.0824038879387;879.3448880583942;880.2078129683272;881.7310720230328;934.4113208678523;935.3546053223288;936.5925822267302;937.723371605378;939.0421769794805;705.6507029020642;783.6277768060182;804.5132694719728;805.5972013993004;930.6510058727977;587.5064945445803;590.1295589006224;591.5740666719955;593.2139914613111;593.2613895699882;12662.36688165588;12703.237805731686;12716.745665086646;12723;12726.300053497054;11983.88016119845;12128.151029427943;12190.39048047603;12314.81527777084;12330.260184388875;9518.23854091678;9735.56189971453;10849.186311026704;10912.50893709777;11001.339919604769;4132;4156.688248381383;4197.286461301586;4240.491141063061;4328.696991210617;44584.3312350315;44896.10207795826;45349.77325113386;45728.54271457276;45830.54169458329;9729.85405218908;9798.216142708567;9945;9957;10101.393916365041;16321.836781632031;16608.418705345495;16689.33242670304;16760;17405.390811321795;6854.965725171442;6961.3970679927725;6977.82555436108;6984.161900571862;7080.504364694525;3848.4804551385205;3934.881953541341;3945.0137465633593;4027.597240275949;4038.45480860086;2749.42262124952;2857.9285517861804;2861.971380286212;2862.470442968058;2866.867587303004;463.63141302663786;482.7055496147347;498.1233029867387;504.88892443662337;508.6058304813799;493.43008824807407;598.3627436779816;606.8361542383532;639.0924886660953;645.6932956845461;7591.544507329578;7890.289873911375;7931.167227441151;7965.721199758096;8183;639.3318981664172;641.515655679968;643.530222937249;644.9451796597342;654.8493846415256;3788.6021967692996;3977.853195189867;3979.42298366741;4024.2957482441043;4045.939310910339;53319.46680533145;53422;54996.62508437321;55028.72485637546;55036.72481637566;35599;35865.28269434649;42952.78523607362;47948.520514795106;50228.748856256214;43625;44286.55713442824;44875.32687009697;45589;45832.541674582826;7986.401019923413;8038.799030024296;8073.111957684532;8212.46618969765;8240.340772738287;30172.5474117884;30243.848780755954;30431.391372172875;30485.54271685971;30972.380552388375;35104.648953510135;35426.468602971494;38511.422328664536;38792.224155517295;40437.59562404338;11065.170112241774;11139;11169.38568378747;11284.492197851281;11556.88443115558;11473.655790326304;11619.47712352963;11844.703882402664;12078.818817717565;12100.092493062879;10697.625583104555;10794.136469082612;10835.729106772395;10865.130789536975;10977.231593788358;11307.830382544103;11387.487563059847;11389.259698119597;11747.118966077407;12280.631581052583;10344.32761870476;10613.416262105658;11029.61396351124;11062.05972492315;11160.386178759922;8620.568971551273;8924;9105.207183906621;9115.772105697411;9228.261739060725;9339.813203735752;9340.486273255035;9384.906150938676;9496.43021418717;9866.654667086617 15:11:30 INFO - PROCESS | 19674 | __end_tp_report 15:11:30 INFO - PROCESS | 19674 | __start_cc_report 15:11:30 INFO - PROCESS | 19674 | _x_x_mozilla_cycle_collect,1123 15:11:30 INFO - PROCESS | 19674 | __end_cc_report 15:11:30 INFO - PROCESS | 19674 | __startTimestamp1462486290403__endTimestamp 15:11:30 INFO - PROCESS | 19674 | 15:11:30 INFO - PROCESS | 19674 | ------- Summary: start ------- 15:11:30 INFO - PROCESS | 19674 | Number of tests: 6 15:11:30 INFO - PROCESS | 19674 | 15:11:30 INFO - PROCESS | 19674 | [#0] dojo.html Cycles:165 Average:4736.05 Median:4864.29 stddev:486.12 (10.0%) stddev-sans-first:460.12 15:11:30 INFO - PROCESS | 19674 | Values: 2681.9 2688.0 2721.9 2753.8 2762.8 4659.4 4695.2 4749.1 4778.5 4836.5 4686.1 4695.8 4766.8 4839.8 4864.3 4303.0 4328.8 4377.2 4403.1 4548.5 4483.7 4497.6 4502.6 4545.9 4549.0 4299.1 4312.2 4342.4 4362.1 4376.4 4280.0 4299.7 4302.4 4426.2 4435.2 4367.5 4369.3 4378.1 4414.3 4417.2 4523.1 4582.5 4669.2 4713.0 4727.9 5082.3 5174.3 5175.0 5178.2 5180.6 5139.0 5145.5 5160.5 5202.3 5207.0 4628.7 4714.1 4746.1 4791.0 4846.3 5217.4 5232.1 5277.3 5283.2 5292.3 5023.0 5043.4 5089.5 5092.6 5094.4 4963.6 5009.9 5044.6 5047.3 5116.8 5007.1 5033.1 5034.4 5035.5 5081.1 4982.2 4997.1 4998.5 5003.6 5044.5 4274.7 4375.3 4391.1 4430.0 4437.4 3835.0 3847.4 3849.4 3887.0 3908.7 4444.2 4459.6 4461.7 4493.2 4506.1 4960.6 5105.7 5158.1 5161.8 5214.6 4414.7 4434.2 4439.8 4442.3 4486.3 4684.6 4697.0 4699.9 4702.5 4741.5 4703.9 4814.3 4845.9 4875.3 4890.0 5120.4 5127.4 5128.6 5142.2 5197.0 4630.8 4826.9 4843.4 4845.9 4895.8 5035.5 5047.6 5061.7 5104.5 5111.6 5137.8 5152.4 5156.7 5166.3 5207.5 4864.6 4971.9 4998.2 5004.3 5007.8 4995.7 5030.0 5053.9 5094.1 5099.7 4938.7 4981.0 5008.5 5020.3 5027.3 4832.3 4928.4 5064.9 5100.8 5123.9 4868.1 4895.7 4912.4 4916.6 4962.9 15:11:30 INFO - PROCESS | 19674 | 15:11:30 INFO - PROCESS | 19674 | [#1] ext.html Cycles:180 Average:45775.98 Median:37353.91 stddev:77103.02 (206.4%) stddev-sans-first:77244.54 15:11:30 INFO - PROCESS | 19674 | Values: 551.5 596.0 606.8 607.2 609.1 41324.4 42860.0 42942.8 42982.4 46758.5 41248.0 41776.0 41849.2 41951.2 42051.4 7862.8 7991.2 8000.2 8003.4 8008.7 7824.9 7979.2 7982.5 7986.5 7987.8 7970.9 8023.6 8023.8 8023.9 8026.6 7960.0 7960.3 7962.3 7969.4 7989.1 7818.1 7892.3 7892.9 7901.1 7906.0 38745.8 39001.2 39079.6 39210.4 39246.8 3128.8 3373.6 3468.8 3491.3 3744.5 29328.3 29700.0 29746.9 30187.5 30949.0 2939.7 2943.4 2960.9 2994.4 3026.7 184313.0 184937.0 184953.0 185032.0 185190.0 46911.5 54071.2 54426.5 58968.8 60702.1 58370.0 58613.4 58646.0 58695.4 58781.7 15374.4 15500.7 15524.1 15527.1 15534.6 9998.6 10296.8 10296.9 11884.7 12088.6 15739.9 16120.9 16229.0 16365.7 16475.9 6507.7 6554.7 6583.8 6594.8 6694.3 834.8 911.2 983.9 1052.9 1100.6 28591.1 29009.3 29278.6 29589.4 29613.1 987.6 1036.3 1043.3 1071.0 1130.3 15227.8 15471.4 15636.8 15683.5 15911.8 346881.0 349833.0 349994.0 350335.0 352120.0 51137.5 52277.6 52332.7 52460.7 52463.2 1146.2 1256.8 1281.6 1313.5 1323.4 27142.5 30139.1 30563.4 30776.7 30996.5 44954.6 45804.3 45834.9 45910.0 45919.8 314198.0 318794.0 320311.0 321120.0 321466.0 32950.0 41331.4 41395.6 43491.6 44777.0 43877.1 44030.8 44596.8 44786.6 45028.8 36180.0 36873.0 37141.3 37643.2 38315.2 36981.6 37095.0 37311.8 37396.0 37483.6 32428.4 32608.7 32914.3 37304.4 37309.0 32202.8 33907.2 34148.8 34209.3 34290.8 25862.6 26397.2 26496.7 26591.6 26632.2 15:11:30 INFO - PROCESS | 19674 | 15:11:30 INFO - PROCESS | 19674 | [#2] jquery.html Cycles:180 Average:23563.45 Median:187692.60 stddev:61107.49 (32.6%) stddev-sans-first:61254.11 15:11:30 INFO - PROCESS | 19674 | Values: 373.0 374.2 377.3 382.6 385.0 16189.3 17670.1 17877.6 17959.3 18317.4 15066.3 15879.6 15992.4 16025.4 16033.5 5017.7 5167.3 5193.9 5197.8 5200.7 3637.4 5151.3 5573.1 5850.7 5855.0 5887.1 5894.3 5917.3 5919.6 5922.1 5727.6 5833.2 5888.4 5907.0 5914.2 3336.8 4853.9 5155.1 5181.5 5196.9 20432.1 20980.8 21012.7 21339.9 21349.5 1983.3 2112.6 2130.4 2356.0 2550.4 12490.8 13041.2 13141.9 13358.3 13547.1 1694.4 1721.8 1780.1 1787.6 1830.7 68094.5 68105.0 68580.3 69229.7 70729.6 9131.4 9235.8 9647.2 9649.8 9679.8 13375.5 13459.2 13476.3 13486.3 13496.7 7325.5 7383.7 7384.0 7484.6 7532.6 7148.2 7165.3 7192.0 7270.8 7272.5 6119.9 6239.0 6254.5 6281.3 6359.0 1627.1 1707.4 1777.1 1799.3 1811.7 883.6 933.0 952.3 1015.3 1038.5 17057.4 17232.0 17282.3 17680.3 17768.8 881.0 903.6 943.1 976.2 980.4 9915.9 9916.5 10125.9 10147.6 10182.4 367979.0 369610.0 370152.0 372079.0 375011.0 68179.0 70335.6 70778.6 70880.3 71944.3 963.2 992.3 1019.5 1024.1 1029.9 15729.4 15943.9 16017.0 16031.0 16493.3 32197.5 32489.4 32872.8 33555.3 37154.0 38771.4 45584.0 47059.3 48630.3 49002.6 7346.4 7610.3 7657.5 7748.6 7757.8 11582.7 11612.4 11777.8 11867.5 12087.9 9665.5 10257.9 10305.8 10309.4 10578.7 10252.1 10278.7 10289.4 10521.5 10619.5 10171.6 10446.5 10504.1 10525.4 10721.5 7361.8 7368.9 7439.9 7554.3 7619.7 9024.9 9849.5 9929.6 9997.2 10017.1 15:11:30 INFO - PROCESS | 19674 | 15:11:30 INFO - PROCESS | 19674 | [#3] mootools.html Cycles:180 Average:5027.51 Median:5252.66 stddev:2772.86 (52.8%) stddev-sans-first:2766.36 15:11:30 INFO - PROCESS | 19674 | Values: 1284.1 1512.0 1520.2 1711.6 1850.9 6607.6 7391.6 7590.3 7606.1 7791.0 7312.5 7451.5 7453.1 7461.1 7476.1 2191.8 2206.4 2214.2 2216.1 2217.0 2148.8 2164.9 2170.8 2172.6 2181.2 2140.9 2148.3 2157.7 2157.8 2189.7 2097.6 2099.2 2103.9 2104.5 2107.4 2102.5 2155.0 2155.3 2158.3 2159.1 7421.4 7537.4 7597.8 7654.2 7683.6 4528.5 4634.0 4662.9 4664.0 4677.7 2801.0 2817.2 2856.5 2877.9 2941.6 892.1 919.4 923.2 945.2 949.9 10295.3 10427.4 10432.9 10438.1 10457.9 3775.6 3889.1 3940.2 3940.3 4022.5 8289.0 8336.9 8349.0 8359.0 8371.8 4472.2 4475.0 4485.9 4497.8 4503.0 3558.3 4049.5 4050.5 4118.7 4190.4 3424.9 3473.5 3530.4 3558.4 3580.1 1030.0 1057.8 1071.5 1079.0 1079.0 859.8 870.3 871.9 883.5 893.3 5176.9 5179.9 5235.5 5263.4 5296.1 851.1 897.7 922.5 927.9 944.7 3583.8 3628.9 3646.1 3664.1 3728.8 9117.5 9360.2 9554.6 9556.0 9573.8 9243.0 9330.7 9455.8 9457.4 9499.6 6962.9 7004.5 7089.4 7098.4 7109.2 5112.4 5177.5 5241.9 5309.7 5428.1 8487.6 8733.0 8855.9 8926.2 8959.2 8856.6 8871.0 8964.2 8983.8 8988.7 5735.2 5964.3 6090.0 6249.2 6442.4 7195.0 7239.2 7279.2 7292.1 7294.2 6467.2 6647.8 6669.9 6730.8 6836.4 6611.6 6617.9 6634.3 6656.0 6708.0 6282.4 6338.7 6348.1 6349.5 6356.5 4552.0 4614.8 4704.8 4786.9 4811.3 4754.2 4833.2 4857.3 4894.7 4934.4 15:11:30 INFO - PROCESS | 19674 | 15:11:30 INFO - PROCESS | 19674 | [#4] prototype.html Cycles:180 Average:3977.30 Median:4566.93 stddev:1130.67 (24.8%) stddev-sans-first:1099.43 15:11:30 INFO - PROCESS | 19674 | Values: 289.1 291.9 295.6 296.2 298.0 4625.7 4640.1 4651.3 4695.0 4695.7 4635.8 4648.9 4655.0 4655.9 4659.5 3491.3 3597.1 3623.3 3693.2 3707.5 3659.2 3681.0 3697.8 3733.9 3740.8 3497.6 3661.8 3682.0 3692.5 3698.3 3595.2 3666.0 3676.3 3694.1 3713.2 3278.2 3289.4 3290.8 3303.5 3309.6 4427.2 4459.5 4469.9 4476.3 4506.9 3933.8 4169.8 4171.0 4178.5 4192.0 4847.3 4856.2 4873.9 4881.1 4900.6 3489.9 3504.3 3507.2 3507.8 3523.8 4964.7 5007.6 5053.6 5090.4 5093.3 3576.3 3591.3 3594.2 3598.8 3606.7 3633.5 3638.6 3645.3 3646.6 3650.3 4124.8 4130.9 4132.9 4138.2 4140.2 4677.2 4864.5 4880.4 4882.7 4892.2 1184.8 1189.1 1191.2 1195.1 1204.6 782.0 823.8 834.3 840.2 842.9 4154.3 4159.8 4163.8 4168.4 4176.7 4722.9 4769.5 4803.4 4813.5 4859.7 4020.7 4143.8 4168.4 4198.7 4214.9 2550.5 2550.9 2565.7 2571.3 2572.2 4576.7 4584.3 4596.6 4602.6 4607.6 4631.8 4900.3 4904.7 4915.4 4952.7 4581.6 4590.4 4593.0 4606.8 4609.5 4754.3 4787.6 4798.8 4800.0 4800.3 4560.2 4735.4 4740.0 4758.3 4759.1 4446.8 4548.7 4583.3 4593.3 4593.7 3445.5 3446.1 3460.7 3487.4 3487.6 4750.2 4754.1 4768.8 4789.7 4797.9 4439.7 4604.8 4608.9 4652.6 4687.6 4659.3 4673.6 4674.3 4676.9 4685.6 4552.5 4560.3 4590.4 4609.0 4631.4 4573.5 4661.4 4689.8 4728.5 4872.8 4777.8 4813.3 4822.4 4834.6 4855.3 15:11:30 INFO - PROCESS | 19674 | 15:11:30 INFO - PROCESS | 19674 | [#5] yui.html Cycles:180 Average:12775.20 Median:44885.71 stddev:14431.40 (32.2%) stddev-sans-first:14443.55 15:11:30 INFO - PROCESS | 19674 | Values: 734.1 762.2 762.3 795.0 838.3 11434.4 11468.1 11557.8 11558.1 11594.3 11881.2 11909.1 11932.3 11956.9 11966.2 681.8 858.7 868.1 887.8 891.5 876.7 878.1 879.3 880.2 881.7 934.4 935.4 936.6 937.7 939.0 705.7 783.6 804.5 805.6 930.7 587.5 590.1 591.6 593.2 593.3 12662.4 12703.2 12716.7 12723.0 12726.3 11983.9 12128.2 12190.4 12314.8 12330.3 9518.2 9735.6 10849.2 10912.5 11001.3 4132.0 4156.7 4197.3 4240.5 4328.7 44584.3 44896.1 45349.8 45728.5 45830.5 9729.9 9798.2 9945.0 9957.0 10101.4 16321.8 16608.4 16689.3 16760.0 17405.4 6855.0 6961.4 6977.8 6984.2 7080.5 3848.5 3934.9 3945.0 4027.6 4038.5 2749.4 2857.9 2862.0 2862.5 2866.9 463.6 482.7 498.1 504.9 508.6 493.4 598.4 606.8 639.1 645.7 7591.5 7890.3 7931.2 7965.7 8183.0 639.3 641.5 643.5 644.9 654.8 3788.6 3977.9 3979.4 4024.3 4045.9 53319.5 53422.0 54996.6 55028.7 55036.7 35599.0 35865.3 42952.8 47948.5 50228.7 43625.0 44286.6 44875.3 45589.0 45832.5 7986.4 8038.8 8073.1 8212.5 8240.3 30172.5 30243.8 30431.4 30485.5 30972.4 35104.6 35426.5 38511.4 38792.2 40437.6 11065.2 11139.0 11169.4 11284.5 11556.9 11473.7 11619.5 11844.7 12078.8 12100.1 10697.6 10794.1 10835.7 10865.1 10977.2 11307.8 11387.5 11389.3 11747.1 12280.6 10344.3 10613.4 11029.6 11062.1 11160.4 8620.6 8924.0 9105.2 9115.8 9228.3 9339.8 9340.5 9384.9 9496.4 9866.7 15:11:30 INFO - PROCESS | 19674 | -------- Summary: end -------- 15:11:30 INFO - PROCESS | 19674 | 15:11:31 INFO - TEST-INFO | 19674: exit 0 15:11:31 INFO - TEST-OK | dromaeo_css | took 1119079ms 15:11:31 INFO - TEST-START | kraken 15:11:31 INFO - operating with platform_type : linux_ 15:11:31 INFO - Initialising browser for kraken test... 15:11:31 INFO - TEST-INFO | started process 19852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptAeYCb/profile http://localhost:33554/getInfo.html) 15:11:35 INFO - PROCESS | 19852 | __metrics Screen width/height:1600/1200 15:11:35 INFO - PROCESS | 19852 | colorDepth:24 15:11:35 INFO - PROCESS | 19852 | Browser inner width/height: 1024/697 15:11:35 INFO - PROCESS | 19852 | __metrics 15:11:36 ERROR - PROCESS | 19852 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:11:37 INFO - TEST-INFO | 19852: exit 0 15:11:37 INFO - Browser initialized. 15:11:37 INFO - Running cycle 1/1 for kraken test... 15:11:37 INFO - TEST-INFO | started process 19932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptAeYCb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:49 INFO - PROCESS | 19932 | RSS: Main: 154828800 15:11:49 INFO - PROCESS | 19932 | 15:11:51 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33554/tests/kraken/driver.html?testName=audio-beat-detection) 15:11:52 INFO - PROCESS | 19932 | RSS: Main: 209666048 15:11:52 INFO - PROCESS | 19932 | 15:11:55 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33554/tests/kraken/driver.html?testName=audio-dft) 15:11:56 INFO - PROCESS | 19932 | RSS: Main: 198316032 15:11:56 INFO - PROCESS | 19932 | 15:11:59 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33554/tests/kraken/driver.html?testName=audio-fft) 15:11:59 INFO - PROCESS | 19932 | RSS: Main: 266911744 15:11:59 INFO - PROCESS | 19932 | 15:12:02 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33554/tests/kraken/driver.html?testName=audio-oscillator) 15:12:02 INFO - PROCESS | 19932 | RSS: Main: 176209920 15:12:02 INFO - PROCESS | 19932 | 15:12:04 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33554/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:12:05 INFO - PROCESS | 19932 | RSS: Main: 180592640 15:12:05 INFO - PROCESS | 19932 | 15:12:08 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33554/tests/kraken/driver.html?testName=imaging-darkroom) 15:12:09 INFO - PROCESS | 19932 | RSS: Main: 216592384 15:12:09 INFO - PROCESS | 19932 | 15:12:12 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33554/tests/kraken/driver.html?testName=imaging-desaturate) 15:12:13 INFO - PROCESS | 19932 | RSS: Main: 217071616 15:12:13 INFO - PROCESS | 19932 | 15:12:16 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33554/tests/kraken/driver.html?testName=json-parse-financial) 15:12:16 INFO - PROCESS | 19932 | RSS: Main: 216903680 15:12:16 INFO - PROCESS | 19932 | 15:12:18 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33554/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:12:19 INFO - PROCESS | 19932 | RSS: Main: 202653696 15:12:19 INFO - PROCESS | 19932 | 15:12:21 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33554/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:12:21 INFO - PROCESS | 19932 | RSS: Main: 206094336 15:12:21 INFO - PROCESS | 19932 | 15:12:23 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33554/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:12:24 INFO - PROCESS | 19932 | RSS: Main: 217473024 15:12:24 INFO - PROCESS | 19932 | 15:12:27 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:12:27 INFO - PROCESS | 19932 | RSS: Main: 225316864 15:12:27 INFO - PROCESS | 19932 | 15:12:30 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:12:31 INFO - PROCESS | 19932 | RSS: Main: 221609984 15:12:31 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | Cycle 1(1): loaded http://localhost:33554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33554/tests/kraken/driver.html?testName=ai-astar) 15:12:33 INFO - PROCESS | 19932 | RSS: Main: 266547200 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | __start_tp_report 15:12:33 INFO - PROCESS | 19932 | _x_x_mozilla_page_load 15:12:33 INFO - PROCESS | 19932 | _x_x_mozilla_page_load_details 15:12:33 INFO - PROCESS | 19932 | |i|pagename|runs| 15:12:33 INFO - PROCESS | 19932 | |0;ai-astar;114;111;115;114;114;114;115;115;112;114 15:12:33 INFO - PROCESS | 19932 | |1;audio-beat-detection;152;132;165;185;131;157;158;132;184;131 15:12:33 INFO - PROCESS | 19932 | |2;audio-dft;161;161;161;160;161;161;162;160;161;161 15:12:33 INFO - PROCESS | 19932 | |3;audio-fft;75;76;76;136;75;74;77;75;130;76 15:12:33 INFO - PROCESS | 19932 | |4;audio-oscillator;94;93;120;93;92;94;127;92;92;120 15:12:33 INFO - PROCESS | 19932 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;116;117;117 15:12:33 INFO - PROCESS | 19932 | |6;imaging-darkroom;146;146;146;145;145;146;146;145;146;145 15:12:33 INFO - PROCESS | 19932 | |7;imaging-desaturate;95;94;95;94;94;95;94;96;95;95 15:12:33 INFO - PROCESS | 19932 | |8;json-parse-financial;65;68;66;67;67;66;67;83;64;63 15:12:33 INFO - PROCESS | 19932 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;65;64;65 15:12:33 INFO - PROCESS | 19932 | |10;stanford-crypto-aes;84;83;82;83;86;83;90;86;84;87 15:12:33 INFO - PROCESS | 19932 | |11;stanford-crypto-ccm;134;134;142;135;133;141;133;140;172;138 15:12:33 INFO - PROCESS | 19932 | |12;stanford-crypto-pbkdf2;177;177;178;176;177;179;176;182;172;172 15:12:33 INFO - PROCESS | 19932 | |13;stanford-crypto-sha256-iterative;68;68;68;68;68;72;69;67;67;67 15:12:33 INFO - PROCESS | 19932 | __end_tp_report 15:12:33 INFO - PROCESS | 19932 | __start_cc_report 15:12:33 INFO - PROCESS | 19932 | _x_x_mozilla_cycle_collect,1898 15:12:33 INFO - PROCESS | 19932 | __end_cc_report 15:12:33 INFO - PROCESS | 19932 | __startTimestamp1462486353460__endTimestamp 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | ------- Summary: start ------- 15:12:33 INFO - PROCESS | 19932 | Number of tests: 14 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:1.32 (1.2%) stddev-sans-first:1.39 15:12:33 INFO - PROCESS | 19932 | Values: 114.0 111.0 115.0 114.0 114.0 114.0 115.0 115.0 112.0 114.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:157.50 stddev:21.13 (13.4%) stddev-sans-first:22.42 15:12:33 INFO - PROCESS | 19932 | Values: 152.0 132.0 165.0 185.0 131.0 157.0 158.0 132.0 184.0 131.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:12:33 INFO - PROCESS | 19932 | Values: 161.0 161.0 161.0 160.0 161.0 161.0 162.0 160.0 161.0 161.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#3] audio-fft Cycles:10 Average:87.00 Median:75.50 stddev:24.30 (32.2%) stddev-sans-first:25.38 15:12:33 INFO - PROCESS | 19932 | Values: 75.0 76.0 76.0 136.0 75.0 74.0 77.0 75.0 130.0 76.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:92.50 stddev:14.38 (15.6%) stddev-sans-first:14.98 15:12:33 INFO - PROCESS | 19932 | Values: 94.0 93.0 120.0 93.0 92.0 94.0 127.0 92.0 92.0 120.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:12:33 INFO - PROCESS | 19932 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:12:33 INFO - PROCESS | 19932 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:12:33 INFO - PROCESS | 19932 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 94.0 96.0 95.0 95.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:67.00 stddev:5.62 (8.4%) stddev-sans-first:5.88 15:12:33 INFO - PROCESS | 19932 | Values: 65.0 68.0 66.0 67.0 67.0 66.0 67.0 83.0 64.0 63.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 15:12:33 INFO - PROCESS | 19932 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:2.44 (2.9%) stddev-sans-first:2.57 15:12:33 INFO - PROCESS | 19932 | Values: 84.0 83.0 82.0 83.0 86.0 83.0 90.0 86.0 84.0 87.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:139.00 stddev:11.68 (8.4%) stddev-sans-first:12.17 15:12:33 INFO - PROCESS | 19932 | Values: 134.0 134.0 142.0 135.0 133.0 141.0 133.0 140.0 172.0 138.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:177.00 stddev:2.99 (1.7%) stddev-sans-first:3.17 15:12:33 INFO - PROCESS | 19932 | Values: 177.0 177.0 178.0 176.0 177.0 179.0 176.0 182.0 172.0 172.0 15:12:33 INFO - PROCESS | 19932 | 15:12:33 INFO - PROCESS | 19932 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 15:12:33 INFO - PROCESS | 19932 | Values: 68.0 68.0 68.0 68.0 68.0 72.0 69.0 67.0 67.0 67.0 15:12:33 INFO - PROCESS | 19932 | -------- Summary: end -------- 15:12:33 INFO - PROCESS | 19932 | 15:12:34 INFO - TEST-INFO | 19932: exit 0 15:12:34 INFO - TEST-OK | kraken | took 63344ms 15:12:34 INFO - SUITE-END | took 1182s 15:12:34 INFO - Completed test suite (00:19:42) 15:12:34 INFO - javascript benchmark 15:12:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2681.8793154308055, 2687.9596806047907, 2721.9047333343337, 2753.834769913804, 2762.7651649609784, 4659.3709849170355, 4695.17834378984, 4749.073930583538, 4778.474367819542, 4836.540528649777, 4686.109639168556, 4695.788689508971, 4766.809327626891, 4839.75801209939, 4864.294677271793, 4302.978485107586, 4328.826846926135, 4377.212101821671, 4403.141387429437, 4548.49966503686, 4483.663725220606, 4497.550244975492, 4502.639788816887, 4545.863624091283, 4549.044700612875, 4299.118680670455, 4312.22379971605, 4342.370356298319, 4362.127574485084, 4376.387305777193, 4279.957200428018, 4299.677524185668, 4302.440682711259, 4426.203283408985, 4435.201663700533, 4367.45406824147, 4369.3227549729845, 4378.1462614790125, 4414.3157810539415, 4417.182821178092, 4523.095380923828, 4582.450105987269, 4669.1828929937465, 4712.95287047132, 4727.881802954954, 5082.339295891547, 5174.275601415768, 5175.0, 5178.223266510016, 5180.585553155738, 5139.0, 5145.536901678867, 5160.458151894072, 5202.271681964528, 5207.0366982108435, 4628.745419001987, 4714.127886341038, 4746.121967436035, 4790.993891282835, 4846.273059041172, 5217.3999990000875, 5232.136697444955, 5277.261183434322, 5283.1546952487415, 5292.285541451932, 5023.045621331935, 5043.445221025684, 5089.491050894955, 5092.567131793839, 5094.439611642716, 4963.553280204799, 5009.874753131128, 5044.596432285409, 5047.268146118792, 5116.769745361467, 5007.123753343223, 5033.144365457808, 5034.421041580265, 5035.496450354935, 5081.110805609003, 4982.227754698028, 4997.100521906019, 4998.475160108209, 5003.649744517848, 5044.495550444926, 4274.679399045084, 4375.321825117112, 4391.099824536026, 4430.047539778963, 4437.356583295468, 3835.0412396900774, 3847.3844184930836, 3849.4225866120305, 3887.028242939265, 3908.6677632401565, 4444.2222611042935, 4459.576340247671, 4461.709988850779, 4493.168763778712, 4506.121306345297, 4960.627952903546, 5105.719185444762, 5158.071547121479, 5161.767720452589, 5214.556762675139, 4414.690971632019, 4434.201843668171, 4439.755813430228, 4442.267025940748, 4486.327050942385, 4684.648651351163, 4697.037107392976, 4699.906001879944, 4702.52974702527, 4741.5495527924795, 4703.858884233478, 4814.253790662453, 4845.927311090407, 4875.341828853059, 4890.021995600823, 5120.385553733576, 5127.3847138343635, 5128.6153538485505, 5142.17725163987, 5197.038547868505, 4630.76846157684, 4826.903461930812, 4843.4430040545785, 4845.927311090407, 4895.755212239303, 5035.471275516018, 5047.646664733434, 5061.6962982221185, 5104.464031276811, 5111.616628752784, 5137.845864624067, 5152.407473140487, 5156.716380598953, 5166.2508936204795, 5207.531322181022, 4864.610831133572, 4971.9005619886675, 4998.175301075282, 5004.3494345734825, 5007.7746501408255, 4995.725235111959, 5030.0191462664425, 5053.949460505348, 5094.133997220407, 5099.6685215460875, 4938.703677779345, 4981.028699403581, 5008.549230569266, 5020.297158397901, 5027.271045698426, 4832.299316599003, 4928.383952005999, 5064.924026139684, 5100.846974590768, 5123.949590334048, 4868.123737727243, 4895.681780684244, 4912.435069966999, 4916.582090522203, 4962.900741985068], "value": 4705.994915577239, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.5229326632464, 595.9702014899254, 606.8348770360909, 607.2470137030084, 609.0620444515447, 41324.38013429797, 42860.0, 42942.785286073566, 42982.355264671016, 46758.53241467593, 41248.0, 41776.0, 41849.16301673964, 41951.16097678052, 42051.36922946158, 7862.803429914241, 7991.24083212094, 8000.199980002011, 8003.399745019117, 8008.719694810683, 7824.921750782476, 7979.241972012649, 7982.521048737065, 7986.480878742892, 7987.760367188994, 7970.920290797076, 8023.558704271263, 8023.839523209533, 8023.879641805348, 8026.558539280337, 7960.0, 7960.323372513343, 7962.283394494465, 7969.402294827853, 7989.121196668362, 7818.061832580127, 7892.329152022085, 7892.881606775903, 7901.130875603679, 7905.960470197612, 38745.806270968744, 39001.219975600616, 39079.60920390788, 39210.41184382237, 39246.803765981276, 3128.7809853310278, 3373.6457671944336, 3468.791872487659, 3491.30173965208, 3744.475773391727, 29328.266793330124, 29700.0, 29746.85126574375, 30187.547186792217, 30949.0, 2939.6913324100874, 2943.417888142204, 2960.8963686270877, 2994.4160888626725, 3026.6973302669558, 184313.0, 184937.0, 184953.0, 185032.0, 185190.0, 46911.5308846914, 54071.18893216605, 54426.45573544214, 58968.80827513135, 60702.08946865801, 58370.0, 58613.41386586165, 58646.0, 58695.413045869, 58781.70609146927, 15374.385024599114, 15500.689986200212, 15524.14617196065, 15527.068375897255, 15534.611634709223, 9998.600055997678, 10296.794064118825, 10296.948515257376, 11884.702882427835, 12088.576899808464, 15739.921300393426, 16120.919395403182, 16228.971378577678, 16365.672686546202, 16475.91762041206, 6507.7071531781185, 6554.672266386661, 6583.80248592543, 6594.8351291218105, 6694.330566943364, 834.8330333933237, 911.2300106410073, 983.8509316770186, 1052.905238528536, 1100.5982816272003, 28591.14226573206, 29009.274768130967, 29278.560821587693, 29589.408211835642, 29613.111606651833, 987.5802783816849, 1036.2694300518117, 1043.2853495355555, 1070.9518071686794, 1130.3331034689409, 15227.771583426258, 15471.381144754083, 15636.843631563539, 15683.451079212173, 15911.761323580156, 346881.0, 349833.0, 349994.0, 350335.0, 352120.0, 51137.48862511402, 52277.647505862325, 52332.73833630807, 52460.73769631204, 52463.213051804254, 1146.220570012383, 1256.8428946381703, 1281.6027031620042, 1313.4549162097621, 1323.4243104249683, 27142.457150856477, 30139.09582712522, 30563.388732225674, 30776.69223307738, 30996.53505197469, 44954.55045449635, 45804.31293530666, 45834.85412864572, 45910.0, 45919.77040114778, 314198.0, 318794.0, 320311.0, 321120.0, 321466.0, 32950.0, 41331.380029300184, 41395.58604414038, 43491.56508435002, 44777.0, 43877.12245755131, 44030.779846100566, 44596.77701611471, 44786.55213447824, 45028.77485612682, 36180.0, 36873.0, 37141.257174856895, 37643.2471350566, 38315.2336953265, 36981.63018369782, 37095.0, 37311.81344093262, 37396.0, 37483.625163748016, 32428.35143297168, 32608.673913260565, 32914.34171316608, 37304.44043339298, 37309.0, 32202.83898580492, 33907.15232119217, 34148.82925585356, 34209.31581368309, 34290.82854585711, 25862.61206081948, 26397.20808375752, 26496.735032649427, 26591.601125983514, 26632.201033969013], "value": 18022.96784626438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.9794861282629, 374.20108069272106, 377.311406682804, 382.60591590661596, 385.0354861073013, 16189.271482783273, 17670.116494175305, 17877.642447151065, 17959.281628734836, 18317.358892438784, 15066.3220155093, 15879.60300992473, 15992.440264590741, 16025.35898564056, 16033.518994430186, 5017.7240251786225, 5167.302414174094, 5193.870153246161, 5197.818076367328, 5200.6619569727845, 3637.381645120336, 5151.278820965068, 5573.052581061209, 5850.707464626752, 5855.033919403293, 5887.116932460122, 5894.292684877799, 5917.260342457193, 5919.644821310713, 5922.111683247525, 5727.570432217601, 5833.241678581779, 5888.38171991939, 5906.970465147669, 5914.231149950522, 3336.799792012487, 4853.9029219415415, 5155.123628983082, 5181.4559471255725, 5196.948030519684, 20432.080556375, 20980.79019209819, 21012.684809727867, 21339.893300533553, 21349.466263343384, 1983.2959299448776, 2112.598606264805, 2130.43543460983, 2355.9764402355927, 2550.3624093976505, 12490.813372729666, 13041.152325098838, 13141.86858131416, 13358.265295408748, 13547.119437236548, 1694.4323651576738, 1721.8106008339073, 1780.1188411736273, 1787.6245988342334, 1830.6979348407497, 68094.53101955306, 68105.0, 68580.3141968584, 69229.65385173092, 70729.64635176791, 9131.360804743737, 9235.76910577241, 9647.228221742243, 9649.758756031155, 9679.806403871884, 13375.53185638498, 13459.192448453125, 13476.258805765581, 13486.258255796025, 13496.717811807863, 7325.450591205681, 7383.667734951832, 7383.963080184672, 7484.550926944401, 7532.623368831537, 7148.17795953472, 7165.283471652897, 7192.0, 7270.818229544304, 7272.49092563526, 6119.877602448015, 6238.968805156036, 6254.499640028786, 6281.340459251713, 6358.968205158944, 1627.1294857251314, 1707.4109432246103, 1777.1380880273057, 1799.2892807341027, 1811.7010693235468, 883.6156272021562, 932.9626814927462, 952.3190918493173, 1015.2892974917587, 1038.4755698372273, 17057.402990895258, 17232.0, 17282.308707651555, 17680.29278828858, 17768.822311776716, 881.0, 903.6114470777628, 943.1370296179057, 976.1751320134475, 980.3823591137538, 9915.851262231072, 9916.4545949972, 10125.898741012643, 10147.64483243083, 10182.439965801805, 367979.0, 369610.0, 370152.0, 372079.0, 375011.0, 68179.0, 70335.64832175909, 70778.64610676914, 70880.2911970884, 71944.28055719376, 963.2294164668237, 992.2954702161402, 1019.5157300282307, 1024.073213741565, 1029.891861354547, 15729.370825166865, 15943.920280398524, 16017.0, 16031.0, 16493.257803398636, 32197.51703724493, 32489.35021299608, 32872.83563582167, 33555.328893422484, 37154.0, 38771.41842872416, 45584.0, 47059.29411058768, 48630.27054594255, 49002.64730956577, 7346.4122870169185, 7610.277023682741, 7657.540547566941, 7748.57382843949, 7757.7672669819995, 11582.6525204244, 11612.361320127475, 11777.823332649845, 11867.525298987945, 12087.939560302493, 9665.516724163623, 10257.948710256402, 10305.845412318971, 10309.381437113798, 10578.735531611772, 10252.077313041862, 10278.743031424274, 10289.43408112561, 10521.526531305957, 10619.469026548797, 10171.593136274467, 10446.529906154394, 10504.054635082879, 10525.36847789135, 10721.463926803784, 7361.8159546011775, 7368.889466657897, 7439.9256007439235, 7554.2823431773895, 7619.733309334147, 9024.864627030469, 9849.507524623883, 9929.602815887283, 9997.150242229493, 10017.14854237398], "value": 8407.668929675105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.0690499387938, 1511.9622009449765, 1520.2170881995771, 1711.5721069732567, 1850.8704390692649, 6607.636579988099, 7391.630418479074, 7590.316871481566, 7606.125295591002, 7791.0, 7312.524685895413, 7451.478396512246, 7453.105627324715, 7461.141968673591, 7476.065491813523, 2191.8356123290737, 2206.360155554887, 2214.2360885494477, 2216.0803266644402, 2216.9556608867815, 2148.7851214878465, 2164.945876353096, 2170.8046275835172, 2172.587208430401, 2181.203860590881, 2140.892955352234, 2148.291063948893, 2157.7302837145357, 2157.7626461089267, 2189.737231532218, 2097.64340062189, 2099.191811152717, 2103.852730308879, 2104.4633618427356, 2107.3677896630948, 2102.4743814046487, 2154.9892250538805, 2155.3426205007468, 2158.298552970291, 2159.1147629471843, 7421.369183619398, 7537.397008239328, 7597.772066838003, 7654.19630938749, 7683.57740324282, 4528.456585209763, 4633.976830115827, 4662.883427914329, 4663.953360466386, 4677.672562920597, 2800.957985630217, 2817.1548535439492, 2856.471552762725, 2877.928051798701, 2941.6322959630047, 892.076700614867, 919.4161707315835, 923.1599244687369, 945.163530275711, 949.9145076943108, 10295.279330446872, 10427.426491542961, 10432.895671043269, 10438.112760415373, 10457.947710261476, 3775.6035616260447, 3889.105505733697, 3940.1725637616423, 3940.2907476653904, 4022.5374081980362, 8289.0467596226, 8336.874946875801, 8349.0, 8358.958205208935, 8371.832563348698, 4472.239719247671, 4475.01549659081, 4485.910281794346, 4497.8425755098415, 4502.977485112553, 3558.288342331544, 4049.493813273341, 4050.4531888195306, 4118.691098167589, 4190.371444283382, 3424.931501369959, 3473.5484387029524, 3530.3998320285614, 3558.395072837624, 3580.0870777951977, 1029.9639512617023, 1057.841323801436, 1071.45891324882, 1079.0342643334172, 1079.0396547073112, 859.7893516088599, 870.3081050564816, 871.9346049046347, 883.4787475389551, 893.3433926064338, 5176.870578235575, 5179.870503237374, 5235.476452354734, 5263.36839579253, 5296.1261391870685, 851.1275942159336, 897.7261935109855, 922.4695799915075, 927.939683920543, 944.6599224279254, 3583.8028908409765, 3628.9455658165148, 3646.106703857519, 3664.13892735207, 3728.813559322023, 9117.498537580497, 9360.204382627417, 9554.617815287449, 9556.0, 9573.808523829624, 9243.029481904437, 9330.720078397659, 9455.810883782286, 9457.38526995743, 9499.572519236652, 6962.930370696228, 7004.474664400191, 7089.432845372357, 7098.36114749675, 7109.1824440189, 5112.437631860418, 5177.508136727005, 5241.947580524298, 5309.681419114711, 5428.077226871363, 8487.618057187565, 8732.99570549395, 8855.911440885766, 8926.196642301964, 8959.1936725695, 8856.64573417082, 8870.983726784241, 8964.193222609736, 8983.820323593362, 8988.730338089868, 5735.225744524436, 5964.254468191476, 6090.0, 6249.156363890998, 6442.387973142544, 7195.02867112933, 7239.167495737847, 7279.162896266997, 7292.124945006633, 7294.2341054190665, 6467.191601049869, 6647.800565983028, 6669.866602668017, 6730.798076057726, 6836.350546698056, 6611.603303801788, 6617.867642647024, 6634.303398143318, 6655.966720166368, 6707.966460167668, 6282.434580887742, 6338.65137417428, 6348.079528468438, 6349.4920406366455, 6356.491480681627, 4551.977240113778, 4614.838480653161, 4704.835330763407, 4786.856394308176, 4811.302361157683, 4754.19178739622, 4833.226683730727, 4857.295692124551, 4894.730789806595, 4934.407871055353], "value": 4078.6051368742264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.1441333652389, 291.9401522687849, 295.5788002097011, 296.19287441721315, 297.9985100074499, 4625.653076019299, 4640.095181439612, 4651.302304654304, 4694.953050469494, 4695.67130300879, 4635.837745678902, 4648.907021859569, 4655.045715628296, 4655.860324190271, 4659.510751371108, 3491.266833964864, 3597.1366871950804, 3623.3296840084668, 3693.1874987502706, 3707.4994875691705, 3659.213269147133, 3680.963190368089, 3697.8335974881193, 3733.9253214935684, 3740.775553466787, 3497.5977762557377, 3661.7802931824044, 3682.0426689060905, 3692.48305237267, 3698.2802996606574, 3595.173110184659, 3665.963340366602, 3676.3382591133586, 3694.11341278094, 3713.20166164276, 3278.1804548862783, 3289.3914625794305, 3290.835458227079, 3303.4714445688815, 3309.5603412515634, 4427.225235583792, 4459.487158976727, 4469.882529367658, 4476.261416866213, 4506.909861802746, 3933.7836418996944, 4169.770662613555, 4171.0, 4178.519470260929, 4191.97904010481, 4847.345608342864, 4856.15017371962, 4873.926891096637, 4881.072596206709, 4900.603328051524, 3489.94765078524, 3504.281622267429, 3507.158282012324, 3507.824608769551, 3523.7885726856216, 4964.702117872903, 5007.574356179765, 5053.620978426596, 5090.38915330159, 5093.312402825608, 3576.338377400189, 3591.3356029134693, 3594.1733401317842, 3598.784072955631, 3606.6573675500786, 3633.5276414066, 3638.636136386393, 3645.343838109166, 3646.556806939357, 3650.3064417760543, 4124.7731374774075, 4130.91738165235, 4132.876013719593, 4138.151678905817, 4140.171965606891, 4677.18149323867, 4864.513548645107, 4880.389951256093, 4882.658213924991, 4892.217245240744, 1184.8163534652142, 1189.143816452153, 1191.2078467818976, 1195.0857593940643, 1204.5904392506416, 781.9609019549, 823.8105235795681, 834.3408707121306, 840.2479780596454, 842.8862103615934, 4154.31453810124, 4159.792010399528, 4163.812628431728, 4168.374743788456, 4176.707630465899, 4722.9137298420865, 4769.451513076041, 4803.3995750531185, 4813.542713442217, 4859.743971539077, 4020.6984476164403, 4143.845200495725, 4168.416421700964, 4198.71170212235, 4214.852480163179, 2550.4644024755007, 2550.91586075917, 2565.666463359751, 2571.3057474481784, 2572.215474280325, 4576.702514336557, 4584.289435137559, 4596.5863072323655, 4602.585767280961, 4607.562281583244, 4631.768411579407, 4900.30939325932, 4904.681195722266, 4915.3855768029, 4952.653314268039, 4581.610563102107, 4590.403247577793, 4593.0, 4606.792694328763, 4609.539046095364, 4754.286856971482, 4787.640926930564, 4798.7840547174765, 4800.0, 4800.279958006327, 4560.195479779845, 4735.384400027974, 4740.0, 4758.333833263277, 4759.119562880878, 4446.755428451466, 4548.74981876, 4583.289590113538, 4593.26507758757, 4593.724376537285, 3445.517627532198, 3446.052335607628, 3460.7231421486727, 3487.3897068013503, 3487.6163622001054, 4750.197383543726, 4754.096721622881, 4768.833090841804, 4789.688670236424, 4797.856064318076, 4439.711418757771, 4604.815807367801, 4608.930866037079, 4652.557707110806, 4687.5781179693995, 4659.254519276899, 4673.602743766682, 4674.345591617244, 4676.877549388054, 4685.6017238535105, 4552.52198519164, 4560.335477550737, 4590.35734997094, 4608.976955115203, 4631.374764406762, 4573.519780423007, 4661.394018777537, 4689.835855745033, 4728.456227533878, 4872.757446851172, 4777.784999675093, 4813.302071199727, 4822.38450119214, 4834.63740219492, 4855.295982082507], "value": 3618.6671371804596, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.0823970037453, 762.2225330163234, 762.2567996203701, 794.9761507154785, 838.2832678060258, 11434.42827858608, 11468.139889508278, 11557.768844623102, 11558.075353971682, 11594.304341739502, 11881.227720198181, 11909.106816988717, 11932.284062956229, 11956.880431195685, 11966.162368634199, 681.7613835157705, 858.7423772868145, 868.0538213347465, 887.7691800131947, 891.5453118909338, 876.662484943295, 878.0824038879387, 879.3448880583942, 880.2078129683272, 881.7310720230328, 934.4113208678523, 935.3546053223288, 936.5925822267302, 937.723371605378, 939.0421769794805, 705.6507029020642, 783.6277768060182, 804.5132694719728, 805.5972013993004, 930.6510058727977, 587.5064945445803, 590.1295589006224, 591.5740666719955, 593.2139914613111, 593.2613895699882, 12662.36688165588, 12703.237805731686, 12716.745665086646, 12723.0, 12726.300053497054, 11983.88016119845, 12128.151029427943, 12190.39048047603, 12314.81527777084, 12330.260184388875, 9518.23854091678, 9735.56189971453, 10849.186311026704, 10912.50893709777, 11001.339919604769, 4132.0, 4156.688248381383, 4197.286461301586, 4240.491141063061, 4328.696991210617, 44584.3312350315, 44896.10207795826, 45349.77325113386, 45728.54271457276, 45830.54169458329, 9729.85405218908, 9798.216142708567, 9945.0, 9957.0, 10101.393916365041, 16321.836781632031, 16608.418705345495, 16689.33242670304, 16760.0, 17405.390811321795, 6854.965725171442, 6961.3970679927725, 6977.82555436108, 6984.161900571862, 7080.504364694525, 3848.4804551385205, 3934.881953541341, 3945.0137465633593, 4027.597240275949, 4038.45480860086, 2749.42262124952, 2857.9285517861804, 2861.971380286212, 2862.470442968058, 2866.867587303004, 463.63141302663786, 482.7055496147347, 498.1233029867387, 504.88892443662337, 508.6058304813799, 493.43008824807407, 598.3627436779816, 606.8361542383532, 639.0924886660953, 645.6932956845461, 7591.544507329578, 7890.289873911375, 7931.167227441151, 7965.721199758096, 8183.0, 639.3318981664172, 641.515655679968, 643.530222937249, 644.9451796597342, 654.8493846415256, 3788.6021967692996, 3977.853195189867, 3979.42298366741, 4024.2957482441043, 4045.939310910339, 53319.46680533145, 53422.0, 54996.62508437321, 55028.72485637546, 55036.72481637566, 35599.0, 35865.28269434649, 42952.78523607362, 47948.520514795106, 50228.748856256214, 43625.0, 44286.55713442824, 44875.32687009697, 45589.0, 45832.541674582826, 7986.401019923413, 8038.799030024296, 8073.111957684532, 8212.46618969765, 8240.340772738287, 30172.5474117884, 30243.848780755954, 30431.391372172875, 30485.54271685971, 30972.380552388375, 35104.648953510135, 35426.468602971494, 38511.422328664536, 38792.224155517295, 40437.59562404338, 11065.170112241774, 11139.0, 11169.38568378747, 11284.492197851281, 11556.88443115558, 11473.655790326304, 11619.47712352963, 11844.703882402664, 12078.818817717565, 12100.092493062879, 10697.625583104555, 10794.136469082612, 10835.729106772395, 10865.130789536975, 10977.231593788358, 11307.830382544103, 11387.487563059847, 11389.259698119597, 11747.118966077407, 12280.631581052583, 10344.32761870476, 10613.416262105658, 11029.61396351124, 11062.05972492315, 11160.386178759922, 8620.568971551273, 8924.0, 9105.207183906621, 9115.772105697411, 9228.261739060725, 9339.813203735752, 9340.486273255035, 9384.906150938676, 9496.43021418717, 9866.654667086617], "value": 6033.081490017749, "unit": "score"}], "name": "dromaeo_css", "value": 6316.373492026464, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 115.0, 114.0, 114.0, 114.0, 115.0, 115.0, 112.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 132.0, 165.0, 185.0, 131.0, 157.0, 158.0, 132.0, 184.0, 131.0], "value": 152.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 160.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 136.0, 75.0, 74.0, 77.0, 75.0, 130.0, 76.0], "value": 87.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 120.0, 93.0, 92.0, 94.0, 127.0, 92.0, 92.0, 120.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 67.0, 67.0, 66.0, 67.0, 83.0, 64.0, 63.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 83.0, 86.0, 83.0, 90.0, 86.0, 84.0, 87.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 142.0, 135.0, 133.0, 141.0, 133.0, 140.0, 172.0, 138.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 178.0, 176.0, 177.0, 179.0, 176.0, 182.0, 172.0, 172.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 72.0, 69.0, 67.0, 67.0, 67.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1574.7, "alertThreshold": 2.0}]} 15:12:34 INFO - Return code: 0 15:12:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:12:34 ERROR - # TBPL SUCCESS # 15:12:34 INFO - Running post-action listener: _resource_record_post_action 15:12:34 INFO - Running post-run listener: _resource_record_post_run 15:12:35 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 519254016; Read time: 0; Write time: 659880 15:12:35 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 234819584; Read time: 0; Write time: 390416 15:12:35 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284430336; Read time: 0; Write time: 269464 15:12:35 INFO - Running post-run listener: _upload_blobber_files 15:12:35 INFO - Blob upload gear active. 15:12:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:12:35 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 15:12:35 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'] 15:12:35 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 15:12:36 INFO - (blobuploader) - INFO - Open directory for files ... 15:12:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:12:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:12:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:37 INFO - (blobuploader) - INFO - Done attempting. 15:12:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:12:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:12:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:37 INFO - (blobuploader) - INFO - Done attempting. 15:12:37 INFO - (blobuploader) - INFO - Iteration through files over. 15:12:37 INFO - Return code: 0 15:12:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:12:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:12:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccbf2aa882b8990f58442f3ecbaba4b678ba727f4779c753f7c0cb3e30985bcded978ded88c5cc80a21a808b219f54e050d765ecf1ef562b1e17fe3e8bab9547", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/557227c2c220189dd37174ea39a99de827760426916b4a5fcdacd0270edd29ccb6e29567c8a64db95b50a439220e50a7d30f6793d43b5d55d342824ad2ac1c0b"} 15:12:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:12:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:12:37 INFO - Contents: 15:12:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccbf2aa882b8990f58442f3ecbaba4b678ba727f4779c753f7c0cb3e30985bcded978ded88c5cc80a21a808b219f54e050d765ecf1ef562b1e17fe3e8bab9547", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/557227c2c220189dd37174ea39a99de827760426916b4a5fcdacd0270edd29ccb6e29567c8a64db95b50a439220e50a7d30f6793d43b5d55d342824ad2ac1c0b"} 15:12:37 INFO - Running post-run listener: copy_logs_to_upload_dir 15:12:37 INFO - Copying logs to upload dir... 15:12:37 INFO - mkdir: /builds/slave/test/build/upload/logs 15:12:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.450149 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-05 15:12:37.798200) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 15:12:37.801877) ========= 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=32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198 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/ccbf2aa882b8990f58442f3ecbaba4b678ba727f4779c753f7c0cb3e30985bcded978ded88c5cc80a21a808b219f54e050d765ecf1ef562b1e17fe3e8bab9547", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/557227c2c220189dd37174ea39a99de827760426916b4a5fcdacd0270edd29ccb6e29567c8a64db95b50a439220e50a7d30f6793d43b5d55d342824ad2ac1c0b"} build_url:https://queue.taskcluster.net/v1/task/NeQSNznBQXe-s42Or1m5tQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/NeQSNznBQXe-s42Or1m5tQ/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/ccbf2aa882b8990f58442f3ecbaba4b678ba727f4779c753f7c0cb3e30985bcded978ded88c5cc80a21a808b219f54e050d765ecf1ef562b1e17fe3e8bab9547", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/557227c2c220189dd37174ea39a99de827760426916b4a5fcdacd0270edd29ccb6e29567c8a64db95b50a439220e50a7d30f6793d43b5d55d342824ad2ac1c0b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 15:12:37.828759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:12:37.829397) ========= 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=32c5991c409366f7fec8a718000001d2-1462485117.246120-23324198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:12:37.915087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 15:12:37.915828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 15:12:37.916497) ========= ========= Total master_lag: 0.17 =========