builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1461914500.76 results: success (0) buildid: 20160429000449 builduid: 1c58c77b48524e148e00bd7df6b1df6d revision: 3e2e4184eeffe605002d06eca912050e88ec3e04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:40.757025) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:40.757529) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:40.757903) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:40.779838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:40.780145) ========= 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=aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 00:21:41-- 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% 220M=0s 2016-04-29 00:21:41 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119878 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:40.914401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:40.914779) ========= 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=aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017761 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:40.964691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 00:21:40.965036) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e2e4184eeffe605002d06eca912050e88ec3e04 --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 3e2e4184eeffe605002d06eca912050e88ec3e04 --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=aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 00:21:41,676 truncating revision to first 12 chars 2016-04-29 00:21:41,676 Setting DEBUG logging. 2016-04-29 00:21:41,676 attempt 1/10 2016-04-29 00:21:41,677 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e2e4184eeff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 00:21:43,030 unpacking tar archive at: fx-team-3e2e4184eeff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.656261 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 00:21:42.634709) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:42.635032) ========= script_repo_revision: 3e2e4184eeffe605002d06eca912050e88ec3e04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:42.635455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:42.635747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 00:21:42.645912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-29 00:21:42.646454) ========= /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=aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:21:43 INFO - MultiFileLogger online at 20160429 00:21:43 in /builds/slave/test 00:21:43 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 00:21:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:21:43 INFO - {'append_to_log': False, 00:21:43 INFO - 'base_work_dir': '/builds/slave/test', 00:21:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:21:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:21:43 INFO - 'branch': 'Fx-Team-Non-PGO', 00:21:43 INFO - 'buildbot_json_path': 'buildprops.json', 00:21:43 INFO - 'config_files': ('talos/linux_config.py',), 00:21:43 INFO - 'default_actions': ('clobber', 00:21:43 INFO - 'read-buildbot-config', 00:21:43 INFO - 'download-and-extract', 00:21:43 INFO - 'populate-webroot', 00:21:43 INFO - 'create-virtualenv', 00:21:43 INFO - 'install', 00:21:43 INFO - 'run-tests'), 00:21:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:21:43 INFO - 'download_minidump_stackwalk': True, 00:21:43 INFO - 'download_symbols': 'ondemand', 00:21:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:21:43 INFO - 'tooltool.py': '/tools/tooltool.py', 00:21:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:21:43 INFO - '/tools/misc-python/virtualenv.py')}, 00:21:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:21:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:21:43 INFO - 'installer_path': 'installer.exe', 00:21:43 INFO - 'log_level': 'info', 00:21:43 INFO - 'log_name': 'talos', 00:21:43 INFO - 'log_to_console': True, 00:21:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:21:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:21:43 INFO - 'opt_config_files': (), 00:21:43 INFO - 'pip_index': False, 00:21:43 INFO - 'sps_profile': False, 00:21:43 INFO - 'sps_profile_interval': 0, 00:21:43 INFO - 'suite': 'dromaeojs', 00:21:43 INFO - 'system_bits': '32', 00:21:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:21:43 INFO - 'title': 'talos-linux64-ix-009', 00:21:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:21:43 INFO - 'use_talos_json': True, 00:21:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:21:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:21:43 INFO - 'work_dir': 'build'} 00:21:43 INFO - ##### 00:21:43 INFO - ##### Running clobber step. 00:21:43 INFO - ##### 00:21:43 INFO - Running pre-action listener: _resource_record_pre_action 00:21:43 INFO - Running main action method: clobber 00:21:43 INFO - rmtree: /builds/slave/test/build 00:21:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:21:44 INFO - Running post-action listener: _resource_record_post_action 00:21:44 INFO - ##### 00:21:44 INFO - ##### Running read-buildbot-config step. 00:21:44 INFO - ##### 00:21:44 INFO - Running pre-action listener: _resource_record_pre_action 00:21:44 INFO - Running main action method: read_buildbot_config 00:21:44 INFO - Using buildbot properties: 00:21:44 INFO - { 00:21:44 INFO - "project": "", 00:21:44 INFO - "product": "firefox", 00:21:44 INFO - "script_repo_revision": "production", 00:21:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:21:44 INFO - "repository": "", 00:21:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:21:44 INFO - "buildid": "20160429000449", 00:21:44 INFO - "pgo_build": "False", 00:21:44 INFO - "basedir": "/builds/slave/test", 00:21:44 INFO - "buildnumber": 2911, 00:21:44 INFO - "slavename": "talos-linux64-ix-009", 00:21:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:21:44 INFO - "platform": "ubuntu64_hw", 00:21:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:21:44 INFO - "branch": "fx-team", 00:21:44 INFO - "repo_path": "integration/fx-team", 00:21:44 INFO - "revision": "3e2e4184eeffe605002d06eca912050e88ec3e04", 00:21:44 INFO - "stage_platform": "linux64", 00:21:44 INFO - "builduid": "1c58c77b48524e148e00bd7df6b1df6d", 00:21:44 INFO - "slavebuilddir": "test" 00:21:44 INFO - } 00:21:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 00:21:44 INFO - Running post-action listener: _resource_record_post_action 00:21:44 INFO - ##### 00:21:44 INFO - ##### Running download-and-extract step. 00:21:44 INFO - ##### 00:21:44 INFO - Running pre-action listener: _resource_record_pre_action 00:21:44 INFO - Running main action method: download_and_extract 00:21:44 INFO - mkdir: /builds/slave/test/build/tests 00:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:21:44 INFO - https://queue.taskcluster.net/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:21:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:21:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:21:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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 00:21:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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 00:21:48 INFO - Downloaded 1361 bytes. 00:21:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:21:48 INFO - Using the following test package requirements: 00:21:48 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:21:48 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:21:48 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:21:48 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:21:48 INFO - u'jsshell-linux-x86_64.zip'], 00:21:48 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:21:48 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:21:48 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:21:48 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:21:48 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:21:48 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:21:48 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:21:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:21:48 INFO - https://queue.taskcluster.net/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:21:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:21:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:21:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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 00:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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 00:21:52 INFO - Downloaded 22301604 bytes. 00:21:52 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'] 00:21:52 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 00:21:53 INFO - Return code: 0 00:21:53 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 00:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:21:53 INFO - https://queue.taskcluster.net/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:21:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:21:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:21:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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 00:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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 00:21:57 INFO - Downloaded 22301604 bytes. 00:21:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:21:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:21:58 INFO - Return code: 0 00:21:58 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')]} 00:21:58 INFO - https://queue.taskcluster.net/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:21:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:21:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:21:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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 00:21:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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 00:21:59 INFO - Downloaded 10840145 bytes. 00:21:59 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'] 00:21:59 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 00:21:59 INFO - Return code: 0 00:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:21:59 INFO - https://queue.taskcluster.net/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:21:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:21:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:21:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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 00:21:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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 00:22:01 INFO - Downloaded 54853399 bytes. 00:22:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:22:01 INFO - mkdir: /builds/slave/test/properties 00:22:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:22:01 INFO - Writing to file /builds/slave/test/properties/build_url 00:22:01 INFO - Contents: 00:22:01 INFO - build_url:https://queue.taskcluster.net/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:22:01 INFO - Running post-action listener: _resource_record_post_action 00:22:01 INFO - Running post-action listener: set_extra_try_arguments 00:22:01 INFO - ##### 00:22:01 INFO - ##### Running populate-webroot step. 00:22:01 INFO - ##### 00:22:01 INFO - Running pre-action listener: _resource_record_pre_action 00:22:01 INFO - Running main action method: populate_webroot 00:22:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:22:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:22:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:22:01 INFO - '--tppagecycles', 00:22:01 INFO - '7'], 00:22:01 INFO - 'tests': ['tsvgm']}}, 00:22:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:22:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:22:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:22:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:22:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:22:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:22:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:01 INFO - 'talos_options': ['--disable-e10s'], 00:22:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:22:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:22:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:01 INFO - 'talos_options': ['--disable-e10s'], 00:22:01 INFO - 'tests': ['damp', 'tps']}, 00:22:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:01 INFO - 'tests': ['damp', 'tps']}, 00:22:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:22:01 INFO - 'tests': ['dromaeo_dom']}, 00:22:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:22:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:22:01 INFO - 'tests': ['a11yr', 00:22:01 INFO - 'ts_paint', 00:22:01 INFO - 'tpaint', 00:22:01 INFO - 'sessionrestore', 00:22:01 INFO - 'sessionrestore_no_auto_restore', 00:22:01 INFO - 'tabpaint']}, 00:22:01 INFO - 'other-e10s': {'tests': ['a11yr', 00:22:01 INFO - 'ts_paint', 00:22:01 INFO - 'tpaint', 00:22:01 INFO - 'sessionrestore', 00:22:01 INFO - 'sessionrestore_no_auto_restore', 00:22:01 INFO - 'tabpaint']}, 00:22:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:22:01 INFO - 'ts_paint', 00:22:01 INFO - 'tpaint', 00:22:01 INFO - 'sessionrestore', 00:22:01 INFO - 'sessionrestore_no_auto_restore', 00:22:01 INFO - 'tabpaint']}, 00:22:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:22:01 INFO - 'ts_paint', 00:22:01 INFO - 'tpaint', 00:22:01 INFO - 'sessionrestore', 00:22:01 INFO - 'sessionrestore_no_auto_restore', 00:22:01 INFO - 'tabpaint']}, 00:22:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:22:01 INFO - 'tests': ['a11yr', 00:22:01 INFO - 'ts_paint', 00:22:01 INFO - 'tpaint', 00:22:01 INFO - 'sessionrestore', 00:22:01 INFO - 'sessionrestore_no_auto_restore', 00:22:01 INFO - 'tabpaint']}, 00:22:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:22:01 INFO - 'tests': ['a11yr', 00:22:01 INFO - 'ts_paint', 00:22:01 INFO - 'tpaint', 00:22:01 INFO - 'sessionrestore', 00:22:01 INFO - 'sessionrestore_no_auto_restore', 00:22:01 INFO - 'tabpaint']}, 00:22:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:22:01 INFO - 'tests': ['tsvgx', 00:22:01 INFO - 'tsvgr_opacity', 00:22:01 INFO - 'tart', 00:22:01 INFO - 'tscrollx', 00:22:01 INFO - 'cart']}, 00:22:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:22:01 INFO - 'tsvgr_opacity', 00:22:01 INFO - 'tart', 00:22:01 INFO - 'tscrollx', 00:22:01 INFO - 'cart']}, 00:22:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:01 INFO - 'talos_options': ['--disable-e10s'], 00:22:01 INFO - 'tests': ['tp5o']}, 00:22:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:01 INFO - 'tests': ['tp5o']}, 00:22:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:01 INFO - 'talos_options': ['--disable-e10s', 00:22:01 INFO - '--xperf_path', 00:22:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:22:01 INFO - 'tests': ['tp5n']}, 00:22:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:22:01 INFO - 'talos_options': ['--xperf_path', 00:22:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:22:01 INFO - 'tests': ['tp5n']}}, 00:22:01 INFO - 'talos.zip': {'path': '', 00:22:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:22:01 INFO - Running post-action listener: _resource_record_post_action 00:22:01 INFO - ##### 00:22:01 INFO - ##### Running create-virtualenv step. 00:22:01 INFO - ##### 00:22:01 INFO - Running pre-action listener: _resource_record_pre_action 00:22:01 INFO - Running main action method: create_virtualenv 00:22:01 INFO - Creating virtualenv /builds/slave/test/build/venv 00:22:01 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 00:22:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:22:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:22:02 INFO - Using real prefix '/usr' 00:22:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:22:02 INFO - Installing distribute.............................................................................................................................................................................................done. 00:22:04 INFO - Installing pip.................done. 00:22:04 INFO - Return code: 0 00:22:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:22: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')]} 00:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22: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')]} 00:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dd02bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf44410>, '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 0xf45310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf457a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', '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 00:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:22:04 INFO - Using env: {'DISPLAY': ':0', 00:22:04 INFO - 'HOME': '/home/cltbld', 00:22:04 INFO - 'LANG': 'en_US.UTF-8', 00:22:04 INFO - 'LANGUAGE': 'en_US:en', 00:22:04 INFO - 'LOGNAME': 'cltbld', 00:22:04 INFO - 'MAIL': '/var/mail/cltbld', 00:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:04 INFO - 'MOZ_NO_REMOTE': '1', 00:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:04 INFO - 'NO_EM_RESTART': '1', 00:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:04 INFO - 'PWD': '/builds/slave/test', 00:22:04 INFO - 'SHELL': '/bin/bash', 00:22:04 INFO - 'SHLVL': '1', 00:22:04 INFO - 'TERM': 'linux', 00:22:04 INFO - 'TMOUT': '86400', 00:22:04 INFO - 'USER': 'cltbld', 00:22:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', 00:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:04 INFO - '_': '/tools/buildbot/bin/python'} 00:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:04 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 00:22:04 INFO - Cleaning up... 00:22:04 INFO - Return code: 0 00:22:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:22: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')]} 00:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22: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')]} 00:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb5dd02bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf44410>, '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 0xf45310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf457a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', '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 00:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:22:04 INFO - Using env: {'DISPLAY': ':0', 00:22:04 INFO - 'HOME': '/home/cltbld', 00:22:04 INFO - 'LANG': 'en_US.UTF-8', 00:22:04 INFO - 'LANGUAGE': 'en_US:en', 00:22:04 INFO - 'LOGNAME': 'cltbld', 00:22:04 INFO - 'MAIL': '/var/mail/cltbld', 00:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:04 INFO - 'MOZ_NO_REMOTE': '1', 00:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:04 INFO - 'NO_EM_RESTART': '1', 00:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:04 INFO - 'PWD': '/builds/slave/test', 00:22:04 INFO - 'SHELL': '/bin/bash', 00:22:04 INFO - 'SHLVL': '1', 00:22:04 INFO - 'TERM': 'linux', 00:22:04 INFO - 'TMOUT': '86400', 00:22:04 INFO - 'USER': 'cltbld', 00:22:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', 00:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:04 INFO - '_': '/tools/buildbot/bin/python'} 00:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:04 INFO - Downloading/unpacking psutil>=0.7.1 00:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:22:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:22:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:22:06 INFO - Installing collected packages: psutil 00:22:06 INFO - Running setup.py install for psutil 00:22:06 INFO - building 'psutil._psutil_linux' extension 00:22:06 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 00:22:07 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 00:22:07 INFO - building 'psutil._psutil_posix' extension 00:22:07 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 00:22:07 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 00:22:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:22:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:22:07 INFO - Successfully installed psutil 00:22:07 INFO - Cleaning up... 00:22:07 INFO - Return code: 0 00:22:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:07 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 0x7fb5dd02bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf44410>, '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 0xf45310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf457a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', '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 00:22:07 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 00:22:07 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 00:22:07 INFO - Using env: {'DISPLAY': ':0', 00:22:07 INFO - 'HOME': '/home/cltbld', 00:22:07 INFO - 'LANG': 'en_US.UTF-8', 00:22:07 INFO - 'LANGUAGE': 'en_US:en', 00:22:07 INFO - 'LOGNAME': 'cltbld', 00:22:07 INFO - 'MAIL': '/var/mail/cltbld', 00:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:07 INFO - 'MOZ_NO_REMOTE': '1', 00:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:07 INFO - 'NO_EM_RESTART': '1', 00:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:07 INFO - 'PWD': '/builds/slave/test', 00:22:07 INFO - 'SHELL': '/bin/bash', 00:22:07 INFO - 'SHLVL': '1', 00:22:07 INFO - 'TERM': 'linux', 00:22:07 INFO - 'TMOUT': '86400', 00:22:07 INFO - 'USER': 'cltbld', 00:22:07 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', 00:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:07 INFO - '_': '/tools/buildbot/bin/python'} 00:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:22:07 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 00:22:07 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 00:22:07 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 00:22:07 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 00:22:07 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 00:22:07 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 00:22:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:22:09 INFO - Installing collected packages: mozsystemmonitor 00:22:09 INFO - Running setup.py install for mozsystemmonitor 00:22:09 INFO - Successfully installed mozsystemmonitor 00:22:09 INFO - Cleaning up... 00:22:09 INFO - Return code: 0 00:22:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb5dd02bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf44410>, '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 0xf45310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf457a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', '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 00:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:22:09 INFO - Using env: {'DISPLAY': ':0', 00:22:09 INFO - 'HOME': '/home/cltbld', 00:22:09 INFO - 'LANG': 'en_US.UTF-8', 00:22:09 INFO - 'LANGUAGE': 'en_US:en', 00:22:09 INFO - 'LOGNAME': 'cltbld', 00:22:09 INFO - 'MAIL': '/var/mail/cltbld', 00:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:09 INFO - 'MOZ_NO_REMOTE': '1', 00:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:09 INFO - 'NO_EM_RESTART': '1', 00:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:09 INFO - 'PWD': '/builds/slave/test', 00:22:09 INFO - 'SHELL': '/bin/bash', 00:22:09 INFO - 'SHLVL': '1', 00:22:09 INFO - 'TERM': 'linux', 00:22:09 INFO - 'TMOUT': '86400', 00:22:09 INFO - 'USER': 'cltbld', 00:22:09 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', 00:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:09 INFO - '_': '/tools/buildbot/bin/python'} 00:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:09 INFO - Downloading/unpacking blobuploader==1.2.4 00:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:11 INFO - Downloading blobuploader-1.2.4.tar.gz 00:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:22:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:22:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:22:12 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 00:22:12 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 00:22:12 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 00:22:12 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 00:22:12 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 00:22:12 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 00:22:12 INFO - Downloading docopt-0.6.1.tar.gz 00:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:22:12 INFO - Installing collected packages: blobuploader, requests, docopt 00:22:12 INFO - Running setup.py install for blobuploader 00:22:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:22:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:22:12 INFO - Running setup.py install for requests 00:22:12 INFO - Running setup.py install for docopt 00:22:13 INFO - Successfully installed blobuploader requests docopt 00:22:13 INFO - Cleaning up... 00:22:13 INFO - Return code: 0 00:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:22: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')]} 00:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22: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')]} 00:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:13 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 0x7fb5dd02bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf44410>, '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 0xf45310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf457a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', '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 00:22:13 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 00:22:13 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 00:22:13 INFO - Using env: {'DISPLAY': ':0', 00:22:13 INFO - 'HOME': '/home/cltbld', 00:22:13 INFO - 'LANG': 'en_US.UTF-8', 00:22:13 INFO - 'LANGUAGE': 'en_US:en', 00:22:13 INFO - 'LOGNAME': 'cltbld', 00:22:13 INFO - 'MAIL': '/var/mail/cltbld', 00:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:13 INFO - 'MOZ_NO_REMOTE': '1', 00:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:13 INFO - 'NO_EM_RESTART': '1', 00:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:13 INFO - 'PWD': '/builds/slave/test', 00:22:13 INFO - 'SHELL': '/bin/bash', 00:22:13 INFO - 'SHLVL': '1', 00:22:13 INFO - 'TERM': 'linux', 00:22:13 INFO - 'TMOUT': '86400', 00:22:13 INFO - 'USER': 'cltbld', 00:22:13 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', 00:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:13 INFO - '_': '/tools/buildbot/bin/python'} 00:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:22:13 INFO - Running setup.py (path:/tmp/pip-VqnNul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:22:13 INFO - Running setup.py (path:/tmp/pip-_Ypqyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:22:13 INFO - Running setup.py (path:/tmp/pip-pasTRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:22:13 INFO - Running setup.py (path:/tmp/pip-PQPUXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:22:13 INFO - Running setup.py (path:/tmp/pip-IIrIrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:22:13 INFO - Running setup.py (path:/tmp/pip-azDkUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:22:13 INFO - Running setup.py (path:/tmp/pip-WPNOl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:22:13 INFO - Running setup.py (path:/tmp/pip-WLCU7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:22:13 INFO - Running setup.py (path:/tmp/pip-7A_moS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:22:14 INFO - Running setup.py (path:/tmp/pip-eOmAdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:22:14 INFO - Running setup.py (path:/tmp/pip-d3aMOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:22:14 INFO - Running setup.py (path:/tmp/pip-LjAbaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:22:14 INFO - Running setup.py (path:/tmp/pip-MdKnNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:22:14 INFO - Running setup.py (path:/tmp/pip-0bQWvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:22:14 INFO - Running setup.py (path:/tmp/pip-jGzwpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:22:14 INFO - Running setup.py (path:/tmp/pip-ZRo_lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:22:14 INFO - Running setup.py (path:/tmp/pip-21nV28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:22:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:22:14 INFO - Running setup.py install for manifestparser 00:22:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:22:14 INFO - Running setup.py install for mozcrash 00:22:14 INFO - Running setup.py install for mozdebug 00:22:14 INFO - Running setup.py install for mozdevice 00:22:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:22:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:22:14 INFO - Running setup.py install for mozfile 00:22:15 INFO - Running setup.py install for mozhttpd 00:22:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Running setup.py install for mozinfo 00:22:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Running setup.py install for mozInstall 00:22:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Running setup.py install for mozleak 00:22:15 INFO - Running setup.py install for mozlog 00:22:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Running setup.py install for moznetwork 00:22:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Running setup.py install for mozprocess 00:22:15 INFO - Running setup.py install for mozprofile 00:22:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:22:15 INFO - Running setup.py install for mozrunner 00:22:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:22:16 INFO - Running setup.py install for mozscreenshot 00:22:16 INFO - Running setup.py install for moztest 00:22:16 INFO - Running setup.py install for mozversion 00:22:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:22:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:22:16 INFO - Cleaning up... 00:22:16 INFO - Return code: 0 00:22:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:22: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')]} 00:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22: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')]} 00:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:16 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 0x7fb5dd02bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf44410>, '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 0xf45310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf457a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', '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 00:22:16 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 00:22:16 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 00:22:16 INFO - Using env: {'DISPLAY': ':0', 00:22:16 INFO - 'HOME': '/home/cltbld', 00:22:16 INFO - 'LANG': 'en_US.UTF-8', 00:22:16 INFO - 'LANGUAGE': 'en_US:en', 00:22:16 INFO - 'LOGNAME': 'cltbld', 00:22:16 INFO - 'MAIL': '/var/mail/cltbld', 00:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:16 INFO - 'MOZ_NO_REMOTE': '1', 00:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:16 INFO - 'NO_EM_RESTART': '1', 00:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:16 INFO - 'PWD': '/builds/slave/test', 00:22:16 INFO - 'SHELL': '/bin/bash', 00:22:16 INFO - 'SHLVL': '1', 00:22:16 INFO - 'TERM': 'linux', 00:22:16 INFO - 'TMOUT': '86400', 00:22:16 INFO - 'USER': 'cltbld', 00:22:16 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', 00:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:16 INFO - '_': '/tools/buildbot/bin/python'} 00:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:22:16 INFO - Running setup.py (path:/tmp/pip-_k4svW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:22:16 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)) 00:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:22:16 INFO - Running setup.py (path:/tmp/pip-k2bXAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:22:16 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)) 00:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:22:16 INFO - Running setup.py (path:/tmp/pip-rc7jfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:22:16 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)) 00:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:22:16 INFO - Running setup.py (path:/tmp/pip-fwfSGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:22:16 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)) 00:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:22:16 INFO - Running setup.py (path:/tmp/pip-gurWua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:22:16 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)) 00:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:22:16 INFO - Running setup.py (path:/tmp/pip-oeouHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:22:16 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)) 00:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:22:16 INFO - Running setup.py (path:/tmp/pip-6TGeLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:22:17 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)) 00:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:22:17 INFO - Running setup.py (path:/tmp/pip-0LwQ3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:22:17 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)) 00:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:22:17 INFO - Running setup.py (path:/tmp/pip-GcHq1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:22:17 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)) 00:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:22:17 INFO - Running setup.py (path:/tmp/pip-59Qd2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:22:17 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)) 00:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:22:17 INFO - Running setup.py (path:/tmp/pip-9LbzQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:22:17 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)) 00:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:22:17 INFO - Running setup.py (path:/tmp/pip-xoChLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:22:17 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)) 00:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:22:17 INFO - Running setup.py (path:/tmp/pip-_vS3_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:22:17 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)) 00:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:22:17 INFO - Running setup.py (path:/tmp/pip-hOEuYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:22:17 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)) 00:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:22:17 INFO - Running setup.py (path:/tmp/pip-eYlQb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:22:17 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)) 00:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:22:17 INFO - Running setup.py (path:/tmp/pip-Om2lXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:22:17 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)) 00:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:22:17 INFO - Running setup.py (path:/tmp/pip-AFIX4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:22:17 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)) 00:22:17 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)) 00:22:17 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)) 00:22:17 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)) 00:22:17 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)) 00:22:17 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)) 00:22:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:22:17 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 00:22:17 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 00:22:17 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 00:22:17 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 00:22:17 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 00:22:17 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 00:22:19 INFO - Downloading blessings-1.6.tar.gz 00:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:22:19 INFO - Installing collected packages: blessings 00:22:19 INFO - Running setup.py install for blessings 00:22:19 INFO - Successfully installed blessings 00:22:19 INFO - Cleaning up... 00:22:19 INFO - Return code: 0 00:22:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:22:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:22:20 INFO - Reading from file tmpfile_stdout 00:22:20 INFO - Current package versions: 00:22:20 INFO - argparse == 1.2.1 00:22:20 INFO - blessings == 1.6 00:22:20 INFO - blobuploader == 1.2.4 00:22:20 INFO - docopt == 0.6.1 00:22:20 INFO - manifestparser == 1.1 00:22:20 INFO - mozInstall == 1.12 00:22:20 INFO - mozcrash == 0.17 00:22:20 INFO - mozdebug == 0.1 00:22:20 INFO - mozdevice == 0.48 00:22:20 INFO - mozfile == 1.2 00:22:20 INFO - mozhttpd == 0.7 00:22:20 INFO - mozinfo == 0.9 00:22:20 INFO - mozleak == 0.1 00:22:20 INFO - mozlog == 3.1 00:22:20 INFO - moznetwork == 0.27 00:22:20 INFO - mozprocess == 0.22 00:22:20 INFO - mozprofile == 0.28 00:22:20 INFO - mozrunner == 6.11 00:22:20 INFO - mozscreenshot == 0.1 00:22:20 INFO - mozsystemmonitor == 0.0 00:22:20 INFO - moztest == 0.7 00:22:20 INFO - mozversion == 1.4 00:22:20 INFO - psutil == 3.1.1 00:22:20 INFO - requests == 1.2.3 00:22:20 INFO - wsgiref == 0.1.2 00:22:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:20 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 0x7fb5dd02bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf44410>, '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 0xf45310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf457a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', '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 00:22:20 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 00:22:20 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 00:22:20 INFO - Using env: {'DISPLAY': ':0', 00:22:20 INFO - 'HOME': '/home/cltbld', 00:22:20 INFO - 'LANG': 'en_US.UTF-8', 00:22:20 INFO - 'LANGUAGE': 'en_US:en', 00:22:20 INFO - 'LOGNAME': 'cltbld', 00:22:20 INFO - 'MAIL': '/var/mail/cltbld', 00:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:20 INFO - 'MOZ_NO_REMOTE': '1', 00:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:20 INFO - 'NO_EM_RESTART': '1', 00:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:20 INFO - 'PWD': '/builds/slave/test', 00:22:20 INFO - 'SHELL': '/bin/bash', 00:22:20 INFO - 'SHLVL': '1', 00:22:20 INFO - 'TERM': 'linux', 00:22:20 INFO - 'TMOUT': '86400', 00:22:20 INFO - 'USER': 'cltbld', 00:22:20 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', 00:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:20 INFO - '_': '/tools/buildbot/bin/python'} 00:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:20 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)) 00:22:20 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)) 00:22:20 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)) 00:22:20 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)) 00:22:20 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)) 00:22:20 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)) 00:22:20 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)) 00:22:20 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)) 00:22:20 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)) 00:22:20 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)) 00:22:20 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)) 00:22:20 INFO - Cleaning up... 00:22:20 INFO - Return code: 0 00:22:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:20 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 0x7fb5dd02bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf44410>, '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 0xf45310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf457a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', '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 00:22:20 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 00:22:20 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 00:22:20 INFO - Using env: {'DISPLAY': ':0', 00:22:20 INFO - 'HOME': '/home/cltbld', 00:22:20 INFO - 'LANG': 'en_US.UTF-8', 00:22:20 INFO - 'LANGUAGE': 'en_US:en', 00:22:20 INFO - 'LOGNAME': 'cltbld', 00:22:20 INFO - 'MAIL': '/var/mail/cltbld', 00:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:20 INFO - 'MOZ_NO_REMOTE': '1', 00:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:20 INFO - 'NO_EM_RESTART': '1', 00:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:20 INFO - 'PWD': '/builds/slave/test', 00:22:20 INFO - 'SHELL': '/bin/bash', 00:22:20 INFO - 'SHLVL': '1', 00:22:20 INFO - 'TERM': 'linux', 00:22:20 INFO - 'TMOUT': '86400', 00:22:20 INFO - 'USER': 'cltbld', 00:22:20 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', 00:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:20 INFO - '_': '/tools/buildbot/bin/python'} 00:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:20 INFO - Downloading/unpacking jsonschema 00:22: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 00:22: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 00:22: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 00:22: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 00:22: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 00:22: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 00:22:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:22:22 INFO - Downloading/unpacking functools32 (from jsonschema) 00:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:22 INFO - Downloading functools32-3.2.3-2.tar.gz 00:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:22:22 INFO - warning: no files found matching '*.txt' 00:22:22 INFO - no previously-included directories found matching 'build' 00:22:22 INFO - no previously-included directories found matching 'dist' 00:22:22 INFO - no previously-included directories found matching '.git*' 00:22:22 INFO - Installing collected packages: jsonschema, functools32 00:22:22 INFO - Running setup.py install for functools32 00:22:22 INFO - warning: no files found matching '*.txt' 00:22:22 INFO - no previously-included directories found matching 'build' 00:22:22 INFO - no previously-included directories found matching 'dist' 00:22:22 INFO - no previously-included directories found matching '.git*' 00:22:22 INFO - Successfully installed jsonschema functools32 00:22:22 INFO - Cleaning up... 00:22:22 INFO - Return code: 0 00:22:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:22:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5dd02bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf44410>, '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 0xf45310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf457a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', '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 00:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:22:22 INFO - Using env: {'DISPLAY': ':0', 00:22:22 INFO - 'HOME': '/home/cltbld', 00:22:22 INFO - 'LANG': 'en_US.UTF-8', 00:22:22 INFO - 'LANGUAGE': 'en_US:en', 00:22:22 INFO - 'LOGNAME': 'cltbld', 00:22:22 INFO - 'MAIL': '/var/mail/cltbld', 00:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:22 INFO - 'MOZ_NO_REMOTE': '1', 00:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:22 INFO - 'NO_EM_RESTART': '1', 00:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:22 INFO - 'PWD': '/builds/slave/test', 00:22:22 INFO - 'SHELL': '/bin/bash', 00:22:22 INFO - 'SHLVL': '1', 00:22:22 INFO - 'TERM': 'linux', 00:22:22 INFO - 'TMOUT': '86400', 00:22:22 INFO - 'USER': 'cltbld', 00:22:22 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', 00:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:22 INFO - '_': '/tools/buildbot/bin/python'} 00:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:22:23 INFO - Downloading/unpacking flake8 00:22:23 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 00:22:23 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 00:22:23 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 00:22:23 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 00:22:23 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 00:22:23 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 00:22:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:22:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:22:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:22:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:22:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:22:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:22:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:22:25 INFO - no previously-included directories found matching 'docs/_build' 00:22:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:22:25 INFO - Running setup.py install for pep8 00:22:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:22:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:22:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:22:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:22:25 INFO - no previously-included directories found matching 'docs/_build' 00:22:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:22:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:22:25 INFO - Cleaning up... 00:22:25 INFO - Return code: 0 00:22:25 INFO - Running post-action listener: _resource_record_post_action 00:22:25 INFO - Running post-action listener: _start_resource_monitoring 00:22:25 INFO - Starting resource monitoring. 00:22:25 INFO - ##### 00:22:25 INFO - ##### Running install step. 00:22:25 INFO - ##### 00:22:25 INFO - Running pre-action listener: _resource_record_pre_action 00:22:25 INFO - Running main action method: install 00:22:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:22:26 INFO - Reading from file tmpfile_stdout 00:22:26 INFO - Detecting whether we're running mozinstall >=1.0... 00:22:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:22:26 INFO - Reading from file tmpfile_stdout 00:22:26 INFO - Output received: 00:22:26 INFO - Usage: mozinstall [options] installer 00:22:26 INFO - Options: 00:22:26 INFO - -h, --help show this help message and exit 00:22:26 INFO - -d DEST, --destination=DEST 00:22:26 INFO - Directory to install application into. [default: 00:22:26 INFO - "/builds/slave/test"] 00:22:26 INFO - --app=APP Application being installed. [default: firefox] 00:22:26 INFO - mkdir: /builds/slave/test/build/application 00:22:26 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'] 00:22:26 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 00:22:42 INFO - Reading from file tmpfile_stdout 00:22:42 INFO - Output received: 00:22:42 INFO - /builds/slave/test/build/application/firefox/firefox 00:22:42 INFO - Running post-action listener: _resource_record_post_action 00:22:42 INFO - ##### 00:22:42 INFO - ##### Running run-tests step. 00:22:42 INFO - ##### 00:22:42 INFO - Running pre-action listener: _resource_record_pre_action 00:22:42 INFO - Running main action method: run_tests 00:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:22:42 INFO - Python 2.7.3 00:22:42 INFO - Return code: 0 00:22:42 INFO - grabbing minidump binary from tooltool 00:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:22:42 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 0xf44410>, '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 0xf45310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf457a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:22:42 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 00:22:42 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 00:22:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:22:42 INFO - Return code: 0 00:22:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:22:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:22:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:22:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:22:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:22:43 INFO - Return code: 0 00:22:43 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/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 00:22:43 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/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 00:22:43 INFO - Using env: {'DISPLAY': ':0', 00:22:43 INFO - 'HOME': '/home/cltbld', 00:22:43 INFO - 'LANG': 'en_US.UTF-8', 00:22:43 INFO - 'LANGUAGE': 'en_US:en', 00:22:43 INFO - 'LOGNAME': 'cltbld', 00:22:43 INFO - 'MAIL': '/var/mail/cltbld', 00:22:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:22:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:22:43 INFO - 'MOZ_NO_REMOTE': '1', 00:22:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:22:43 INFO - 'NO_EM_RESTART': '1', 00:22:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:22:43 INFO - 'PWD': '/builds/slave/test', 00:22:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:22:43 INFO - 'SHELL': '/bin/bash', 00:22:43 INFO - 'SHLVL': '1', 00:22:43 INFO - 'TERM': 'linux', 00:22:43 INFO - 'TMOUT': '86400', 00:22:43 INFO - 'USER': 'cltbld', 00:22:43 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479', 00:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:22:43 INFO - '_': '/tools/buildbot/bin/python'} 00:22:43 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/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 00:22:43 INFO - mozversion application_buildid: 20160429000449 00:22:43 INFO - mozversion application_changeset: 3e2e4184eeffe605002d06eca912050e88ec3e04 00:22:43 INFO - mozversion application_display_name: Nightly 00:22:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:22:43 INFO - mozversion application_name: Firefox 00:22:43 INFO - mozversion application_remotingname: firefox 00:22:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:22:43 INFO - mozversion application_vendor: Mozilla 00:22:43 INFO - mozversion application_version: 49.0a1 00:22:43 INFO - mozversion platform_buildid: 20160429000449 00:22:43 INFO - mozversion platform_changeset: 3e2e4184eeffe605002d06eca912050e88ec3e04 00:22:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:22:43 INFO - mozversion platform_version: 49.0a1 00:22:43 INFO - using testdate: 1461914563 00:22:43 INFO - actual date: 1461914563 00:22:43 INFO - starting webserver on 'localhost:46296' 00:22:43 INFO - SUITE-START | Running 2 tests 00:22:43 INFO - TEST-START | dromaeo_css 00:22:43 INFO - operating with platform_type : linux_ 00:22:43 INFO - Initialising browser for dromaeo_css test... 00:22:43 INFO - TEST-INFO | started process 28849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAWCsae/profile http://localhost:46296/getInfo.html) 00:22:47 INFO - PROCESS | 28849 | __metrics Screen width/height:1600/1200 00:22:47 INFO - PROCESS | 28849 | colorDepth:24 00:22:47 INFO - PROCESS | 28849 | Browser inner width/height: 1024/697 00:22:47 INFO - PROCESS | 28849 | __metrics 00:22:48 ERROR - PROCESS | 28849 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:22:49 INFO - TEST-INFO | 28849: exit 0 00:22:49 INFO - Browser initialized. 00:22:49 INFO - Running cycle 1/1 for dromaeo_css test... 00:22:49 INFO - TEST-INFO | started process 28930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAWCsae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:23:01 INFO - PROCESS | 28930 | RSS: Main: 155815936 00:23:01 INFO - PROCESS | 28930 | 00:23:53 INFO - PROCESS | 28930 | 1461914633108 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] 00:26:06 INFO - PROCESS | 28930 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46296/tests/dromaeo/cssquery-ext.html) 00:26:07 INFO - PROCESS | 28930 | RSS: Main: 257859584 00:26:07 INFO - PROCESS | 28930 | 00:29:09 INFO - PROCESS | 28930 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-ext.html (next: http://localhost:46296/tests/dromaeo/cssquery-jquery.html) 00:29:10 INFO - PROCESS | 28930 | RSS: Main: 227532800 00:29:10 INFO - PROCESS | 28930 | 00:32:12 INFO - PROCESS | 28930 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46296/tests/dromaeo/cssquery-mootools.html) 00:32:13 INFO - PROCESS | 28930 | RSS: Main: 234545152 00:32:13 INFO - PROCESS | 28930 | 00:35:15 INFO - PROCESS | 28930 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46296/tests/dromaeo/cssquery-prototype.html) 00:35:15 INFO - PROCESS | 28930 | RSS: Main: 233062400 00:35:15 INFO - PROCESS | 28930 | 00:38:18 INFO - PROCESS | 28930 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46296/tests/dromaeo/cssquery-yui.html) 00:38:19 INFO - PROCESS | 28930 | RSS: Main: 205352960 00:38:19 INFO - PROCESS | 28930 | 00:41:21 INFO - PROCESS | 28930 | Cycle 1(1): loaded http://localhost:46296/tests/dromaeo/cssquery-yui.html (next: http://localhost:46296/tests/dromaeo/cssquery-dojo.html) 00:41:22 INFO - PROCESS | 28930 | RSS: Main: 271589376 00:41:22 INFO - PROCESS | 28930 | 00:41:22 INFO - PROCESS | 28930 | __start_tp_report 00:41:22 INFO - PROCESS | 28930 | _x_x_mozilla_page_load 00:41:22 INFO - PROCESS | 28930 | _x_x_mozilla_page_load_details 00:41:22 INFO - PROCESS | 28930 | |i|pagename|runs| 00:41:22 INFO - PROCESS | 28930 | |0;dojo.html;2579.9999999999995;2675.839449633021;2677.8342567816253;2686.7716244119247;2717.687465941416;4601.447826260845;4645.117427688737;4647.628189744821;4668.439787225533;4734.7159170449795;4651.418572678415;4686.812527498896;4713.434387873452;4721.645876559263;4731.101090792756;4233.894152646178;4251.171021650764;4281.464816897887;4337.04584991303;4457.910841783162;4364.738115713068;4401.0977749561425;4418.359337896003;4426.026274219666;4451.777411129447;4219.873403797891;4265.466816647919;4333.025069359401;4335.501417336984;4354.869353919387;4310.935335969963;4339.262325404688;4345.565443455661;4361.3457981302745;4378.934315985262;4185.455890734185;4220.704550681454;4243.384709217177;4243.575642435762;4277.230098582254;4396.56034396561;4450.10997800438;4500.954990450086;4514.616257618107;4561.156186105548;4958.281049247839;4959.082569724613;4969.82605608802;4993.800247990076;5018.498150184989;4971.428285747149;4975.527324904128;4992.176290911995;4995.300657907896;4996.475370086161;4578.313253012075;4645.605123564501;4658.836940707059;4669.649776266726;4747.311639812277;5114.41184263807;5128.410232823198;5143.71709555978;5165.1219292720325;5187.118189907725;4909.828156014522;4911.582515486152;4913.361263035782;4926.975365123151;4960.330355402047;4874.488178741252;5008.424031236382;5014.222795466709;5023.271625614266;5088.949110508922;4858.708477491362;4873.756312184377;4874.610031197496;4902.730349830794;4932.728699921467;4864.610831133572;4865.854024379274;4872.4640289568115;4889.804407823718;4938.75306234694;4137.338025915839;4198.3702444633545;4201.537830838605;4203.76879271643;4236.703430759817;3688.4651725499652;3706.29580379727;3766.265578212277;3803.581606023335;3812.4662547243406;4261.616454519108;4262.488501379854;4270.530241673413;4306.82772689089;4311.956880431218;4975.601951843843;4980.950190498049;4991.850244492671;4995.175795993693;5024.899502009939;4138.772367519755;4264.466941632296;4314.09404025152;4380.255356589388;4390.5828946250695;4485.551444855489;4487.461504619467;4493.955060449419;4499.52754960731;4543.591076803037;4726.976365118221;4737.45519265282;4738.573528382462;4740.1230772307235;4744.383230180055;4885.1450996076255;5027.170516864677;5044.117279476003;5096.490350964874;5107.233914912793;4689.812407503661;4715.78778954941;4721.811127554859;4734.621230301636;4783.760811959458;4823.107725070873;4924.285978533164;4926.605871530197;4935.75321233944;4962.751862406937;5030.144875371123;5066.240063990431;5080.644354895122;5112.6165537585575;5139.023585518739;4887.682300650446;4893.339399181065;4895.632827537877;4900.26496025599;4941.579965702812;4711.575958163782;4779.665423420327;4895.951040489549;4899.755012249302;4945.035718034948;4778.617710583076;4788.976055119702;4793.304970779287;4793.616510679068;4797.880052998703;4887.951120488749;4890.755462226945;4892.143874821963;4902.63230257725;4935.851924442272;4658.604018658452;4741.83403580873;4776.761161941959;4805.591524720298;4822.927656085091 00:41:22 INFO - PROCESS | 28930 | |1;ext.html;583.2621733507115;591.2638764737901;608.8295277322349;619.1393962392276;622.85985653228;33850.49224261635;35160;35207.11982200446;35259.64740352596;35301;37071.81464092682;38103;38155.427668584925;38158.42762358567;38226.617733822655;7648.0822301323915;7834.138244793068;7836.138024817265;7836.255555722198;7837.333826624744;7815.882761758578;7965.8805117923275;7979.162187970267;7981.1220765715725;7984.960075199616;7956.641951112185;8015.879761803549;8031.277185053344;8031.839363212733;8037.437379383446;7911.8417631647335;7964.482308649919;7972.960135199345;8007.759767206993;8013.439059265825;7595.924040759577;7704.961475192588;7705.6917723291;7712.190220026872;7720;38288.23423531514;38670;38841.22317553633;38857.611423885966;38895.22209555793;2927.238917881345;3228.983855080733;3385.64450732672;3391.71170450512;3482.373172828915;28583.142505724652;29002.41995160085;29402.852985734935;29851;30817.38365232705;3277.8033318000757;3308.17295676081;3316.3864685033104;3358.8320583970703;3426.0407086015957;242980.78509607515;244317;244549;245134;246518;30162.09513714592;52488.212676809875;52812.471875281524;52958;52972.735136324074;31945.52081718776;31956.680433195834;31977.52033719496;32000.199994999846;32009.67990320067;12962.740745185043;13153.079284449997;13177.868221317663;13215.207087574776;13227.404766785517;10170.440625765506;10206.234532410099;10220.02909723575;10225.897741022494;10234.48827558619;7892.526448412998;8025.638846251933;8103.513789172668;8124.7562573122905;8175.386845986574;3210.7110360067704;3215.9839200803845;3257.1042963185314;3300.3069355435146;3301.7028467437567;911.3301723233418;934.0845970948372;949.6154057606681;964.9758756031156;1060.188955449082;28935;28969.275768105967;28973;29217.269568260963;29433.705662943525;849.5370023337173;972.7713987212999;1006.5219020965129;1007.8740157480315;1021.3157184686278;13895;14699.207150641343;14716.264186790617;14874.181919994287;14960.925195373953;346019;349877;351039;351716;352267;47300.29049564259;48927.26609100866;49238.75380623074;49289.50710492921;49406.50593494091;1199.4662375242933;1220.6277085489012;1258.9496420143275;1262.5896583610363;1275.6173148055545;25707.742922570535;26530.336741581614;27490.725092749617;29031.564526531696;29040.41919161647;35704.64295357013;35836.641633584375;35850.820745896104;35922;35925.82037089798;202122;202380;202483;202559;202725;34220.65779342175;34858;35128.648713512535;35166.64833351736;35612.28775424425;38210.8089459562;38271.42592861165;38583;38853.41719874261;39165.804170980104;32263.838680807385;32972;33188.834055830535;33320.333593327516;33413.16467088342;33437.498437523944;33521;33870.3225935475;34193.65806341905;35192;35353;35770.28459430745;35935;36122.45816312705;36311.81844090763;31352.52971205388;32045.519317209793;32322.515162273055;32396.35207295888;32560.51159232661;24698.382540435912;24880.62679059852;25319.746802532474;25591.48817023612;25629.871850640626 00:41:22 INFO - PROCESS | 28930 | |2;jquery.html;378.5495211150363;381.63553806115164;386.92841824262507;393.8090026337228;395.46217144683226;15694.215289235535;16327.83672163281;16938.661226775457;17219.655606887885;17255.827441725596;15186.924065379686;15577.532674019798;15609.609759756011;15638;15684.137372444511;4984.177610694231;5110.361204849394;5141.665791723526;5153.56194723449;5154.845354639348;3626.655467730561;5525.723713814314;5814.24414826072;5824.359320474744;5830.941690583103;5754.1944127822135;5761.510271626917;5787.189793428924;5788.305403351604;5794.043982742843;5699.886002279952;5848.356680765112;5856.824295271127;5873;5877.265341832271;3345.4814503751713;3536.5756109266795;3541.0970202598173;3542.9114272143147;4916.311716359713;19533.80466195334;19776.30782922605;20023;21006;21056.473588160265;1924.6824273994773;1964.842812575005;1983.2562788954142;2215.556888622266;2509.912153074634;12943.352832358345;12996.350182490838;13002;13059.804102938464;13660.726785464334;1759.463363674079;1784.3219576560953;1821.2532861526843;1860.5441666791723;1881.5296175956012;61144.38855611432;63835;64273;64903.350966490674;65013;9433.6415896026;9505.287103467268;9716.417014978982;9774.657886973922;9863.112319891245;13553.932230338785;13637.181769093886;13657.658558536115;13682.452701892013;13684.52104176369;7245.058142441554;7286.453515986323;7291.963540182265;7496.437767167376;7500.399968002546;7034.577925324497;7039.472039597051;7064.858702825914;7141.500094993301;7150.7497237596435;6088.360722124113;6124.969375153096;6197.628142311476;6247.187865577536;6300.086487459384;1639.2459468644556;1695.940642077546;1803.6843552378282;1834.339637730416;1834.7711013601606;860.2730692564772;872.5506364222431;881.2685471059006;1018.1905385218769;1020.0768304684273;16506.516649777986;17355.65288694219;17374.39189628357;17716.734248986275;17830.37593684215;906.410832958569;957.899420560845;963.4893506441597;983.5868935047297;1043.7651528406047;9941.45322007282;9948.701538953697;10144.746381340377;10171.4914254287;10197.847032294521;399892;409999;414098;418032;419062;70535.64732176409;73130;73805.26194738092;74013.62993185;75339;961.4567769210514;968.2496065549255;984.7291994701371;991.9008099190168;998.5406712912142;15157.772633410286;15357;15513.534593962198;15542.766858496905;15710.214489275262;23477.88261058752;32224.355512889142;33153.50269745907;33166.834165829016;33222.83720069786;43282;44046.559534404245;44613.55386446094;45305.77347113243;45436;7715.27874877647;7763.0684317882215;7799.610019499116;7920.405969552191;7969.880451793112;6857.485688573277;9266.702661627512;11767.293962362286;11815.940920295343;12053.879461205626;10051.095401413908;10101.797964040825;10258.640947566799;10290.897091029294;10325.380477171393;9755.756106097404;10038.548265328223;10243.7439064024;10350.896491034993;10605.151587873106;9878.407295562289;10265.12746416563;10281.9485902573;10388.688339349832;10523.473826308807;7714.382849372149;7800.531968081933;7803.7268695595385;7804.531728096333;7963.124056353912;10443.425611591436;10514.947425262824;10516.211284153565;10549.367037977747;10618 00:41:22 INFO - PROCESS | 28930 | |3;mootools.html;1284.2487145020164;1372.4921778941793;1426.4579459805275;1479.7262506436302;1741.164241164241;6814.182298124226;7647.541147531145;7928.563928983904;7934.642941067651;7935.365170786337;7686.154523002479;7822.843543129148;7824.100228473713;7841.647125879334;7842.647080881374;2220.04538048639;2250.336150835499;2250.4148921280503;2253.43664083979;2254.5040091179912;2199.52710167314;2216.601011817872;2275.8065564427043;2280.0879648140713;2291.1522736587403;2250.651149071888;2259.423846919033;2267.6031694453486;2268.160780511205;2290.278562252893;2146.51703366742;2148.194427089841;2149.3337065509663;2151.612709712251;2154.622940985329;2201.570693714726;2215.069670738294;2215.3353993801957;2217.2128894242474;2218.057325636598;7591.772246832548;7879.251471110236;7928.286454219148;8006.519608823431;8007;4345.891352716176;4437.511873693891;4445.866624001285;4451.666125040602;4483.282674772021;2912.504874171396;2916.2271997920566;2924.1958461423064;2987.4323878463024;2993.491106511898;925.8842644669417;933.0809152984305;944.0936700767272;945.2107490245653;945.8770359853175;10788;10934.835977460423;10970.396628185446;10989.230753847234;10992.230543861933;4038.7374820636564;4218.620324170778;4234.089670720809;4290.871273861789;4294.742315461082;8586.65653373858;8616.353773467015;8616.655333786579;8632.48205107683;8649.91350086491;4565.474970378449;4689.710329659371;4710.36410084641;4723.6929599575915;4724.031573527419;3647.0699971507624;4103.4460347853255;4243.405923170759;4246.915061698749;4295.957040429618;3479.2171761353998;3480.060383696388;3558.733095017884;3574.070741607201;3603.94594081089;1020.3163880200284;1057.138432177788;1061.0397590180899;1067;1077.2405454154803;713.0267185292039;759.2748924776824;762.6301243896705;775.6354513378703;882.4484697064335;5256.237845512379;5309.946900530946;5344.118220493575;5407.918881216785;5473.890522189534;889.3463304471209;901.1664210605164;909.9954500227457;913.1918252346721;930.2929773372285;3650.634936506381;3787.337215987191;3820.025893397166;3837.654611085016;3871.1483473635753;9505.857412138823;9833.754156146011;9933.155681766986;9979;10116.797664046679;9827.066428689262;9847.16299114569;9927.15619172364;9943.055409736064;10019.79960400788;7046.577205367695;7056.012158297843;7233.8553228935125;7234.96382518084;7253.129624444995;5419.34967803866;5480.506754392124;5494.313210848644;5498.560115190695;5506.80726174598;8740.257078148428;8992.955035224782;9017.864732028893;9022.684206052756;9036;8585.527795971282;8833.337499687677;8846.248068913957;8896.911030889867;8998.505082220541;6234.844128896814;6626.867462650816;6819.727210911508;6879.6216208107035;7024.5434046786795;7525.849483010418;7529.322360987538;7605.6577454015805;7622.771316860503;7631.275028872248;6664.933350666432;6711.362420570038;6874;6954.513184077066;6984.615846128511;6789.592624442549;6836.965815170893;6862.245153033262;6905.620190889549;6981.057557229709;6137.478314343331;6197.380261973766;6208.192934918612;6221.129041934042;6447.903281450688;4778.856634300976;4779.641526885428;4782.832600858953;4852.8544143675745;4856.587190088882;4714.858554243378;4734.786934587883;4766.928496072631;4783.258594917794;4855.101806165871 00:41:22 INFO - PROCESS | 28930 | |4;prototype.html;315.2827317851888;316.10699773140874;322.6193092151262;322.6821580742969;323.0743918673003;4595.264757638778;4702.694324868886;4719.457262414823;4760.523947605234;4767.118083154619;4690.718556886589;4692.389989301395;4701.835435759749;4702.882427939303;4709.882252943669;3557.9822100889523;3632.418812989922;3692.504535663061;3770.415585584225;3792.677622402099;3714.1086139326635;3757.2384297541284;3767.3972164453694;3773.113318370181;3776.5271544097823;3527.682508574228;3730.716969067217;3736.6637002669754;3738.9252214955686;3745.6816170625393;3526.818515797211;3673.687736542397;3677.5219221501166;3680.815959202056;3767.6232376762377;3348.2131699050706;3350.8659653613827;3358.2779702363864;3362.747793915466;3371.174062354739;4430.977845110786;4446.666500012479;4457.888552786174;4463.4420697412825;4463.839401755535;3974.8012599369918;4210.873673789792;4221.324588065925;4222;4233.322668373045;4840.467548569654;4893.8711660427825;4909.140900342426;4912.582430493412;4930.802767889316;3542.025942865707;3554.0048786339867;3573.446115852047;3576.7138628909624;3588.5693716753894;5014.398272207359;5081.441041485434;5116.948830511685;5120.948790512047;5184.351956005499;3633.745637805381;3637.8181090945345;3640.5983696277126;3649.61679023704;3671.908202294964;3668.3396988541786;3683.3185860615336;3685.981570092132;3689.8893033209047;3690.4464330350124;4179.101493178981;4185.162967406531;4190.937135942963;4207.600277973587;4214.3889136075095;4654;4904.8773780655765;4907.386576677915;4912.803487860517;4928.704277743347;1335.3657012918786;1338.805873148388;1338.9263590502617;1344.6889282949046;1350.4125705318218;882.4749274181852;904.8959369672572;912.8493798523302;917.6100157433065;919.8482250428605;4138.379243113557;4242.469691288589;4370.562943705668;4406.845760398371;4431.135928493913;5112.565431938327;5120.48795120485;5131.5638170755155;5144.331236939249;5161.406438259573;4375.584319489643;4412.294032954712;4418.646508279394;4420.668449866273;4426.557344265548;2825.138332808472;2901.854907254629;2912.3010477485673;2923.2399576110365;2925.502664547032;5127.435982041972;5131.5638170755155;5149.116494762945;5149.227615857576;5172.741362931838;5002.799888004512;5578.330600327987;5580.246666700024;5589.832305030855;5607.299087614048;4845.6123510119105;4859.31969524274;4874.5856602188505;4877.3903262092235;4890.266460030953;5103.362079740033;5138.717370544507;5163.715995620277;5170.146925757208;5176.197689358005;4865.610751139971;5039.521245481674;5049.495050495068;5053.36832895888;5057.154138739407;4838.443578988461;4847.709137451764;4852.1508735971765;4864.537868902448;4892.804287828447;3654.8355324011013;3682.3671075181373;3697.3344797935556;3708.925821483609;3726.4969229154804;4921.434035086011;5142;5151.484851514819;5155.613329000265;5168.58651307902;4932.495588845437;4974.527419895104;4983.5763960063805;4983.825566105169;5004.3494345734825;4955.55400013986;4957.975210123926;4969.776360063878;4970.204767237369;4994.1759609663995;4700.976495117503;4870.512948705101;4895.265710143507;4901.534354236342;4925.605951523941;4647.977444962103;4806.303086052572;4937.308776771327;4955.752212389438;4970.353853998957;4872.049950259665;4873.561379475864;4877.12211801879;4898.485659005753;4901.705897646153 00:41:22 INFO - PROCESS | 28930 | |5;yui.html;596.439347013807;699.6711545573579;703.3283214530124;705.4708968273794;710.6340234779088;11444.656660300183;11710.590129345475;11931;11958.64124076279;11969.222000569956;10601.04590586849;10674.146068314536;10707.678769636905;10758.408287544202;10775.56897724092;776.3711393771049;791.9941674073951;792.6076592086926;792.9801754956114;793.1275596843484;630.3444417805476;736.5028605691137;787.3779714025912;787.7833595761183;787.9960600196991;833.7582101190648;838.0446291228005;843.1357858195369;844.8394804987064;846.4667259626458;662.3145044878576;839.6263662670115;840.7519781664423;841.5497708725833;842.6418772021897;581.7469400810661;603.1043899808824;604.6976511744128;604.7762327938647;604.8518113062283;12216.633500994983;12557.183783054072;12573.37133143339;12585.056120790885;12599.685007874876;11270.54917803295;11778;12004.399780011052;12212.633620991384;12298.323592202425;9738.90261097394;9767.902320976771;9927.702168934944;9939.50302484873;9996.850047249298;3164.3196712706876;3179.0780673604627;3203.2312245061016;3254.1864533866533;3311.0397984584683;45150.548494514966;45174.32238516425;45704.77147614274;45858.312125318145;45959.77020114911;9249.676261330822;9452.716418507456;9491.145796878314;9558.856617150748;9840.803183936425;17083.914580427267;17123;17125.400610978555;17133.400330988356;17186.82813171852;6547.279799222082;6643.900341494881;6704.3295670433545;6715.865682686416;6899.999500072461;3510.014363230139;3682.3739964206147;3821;3838.6353296436796;3882.2041481496226;2815;2842.332051967786;2865.1834227245135;2868.096549586915;2869.368738877444;503.26523276017423;504.1144636370434;514.0567059445958;514.7374838832222;522.5767128625826;501.6237821633775;509;545.3374150407274;572.044685375424;587.1984740828738;7245.529040612449;7400.814979625445;7537.8115547110665;7673.616319184019;7680.884786728204;498.9376327959005;585.4759989809182;593.3058321763547;629.1380808292669;638.6811234800123;3597;3668.669819716238;3690.6678398944223;3703.5555733311635;3756.4740936268945;52170;53131.468685313426;54039.18941215885;54172.45827541753;54185;46347.30479042817;47186.76406617945;48175.5182448171;48758.51241487611;49007.50992490101;44204.557954420045;44277.33583996243;44415.33376999348;44770;45210.547894520634;7264.23725508814;7345.3021962913435;7410.740624078131;7445.4415918805225;7503.662335195038;29659;29783;30302.393952121274;30604.540931885593;31087.378252435275;35443;37658;39084.60915390924;39223.80388098041;39282;9293.953530232306;9479.620815167316;9513.952430237805;9634.362158433223;9662.951685241529;9156.404833685789;9268.814623707623;9448.149666530046;9568.95215523918;10106;9205.355625106178;9379.484128373006;9594.760130996781;9872.802543949225;9929.056739609725;8938.86591701112;9118.498482583522;9214.44713317203;9389.342746007987;9429.717108486757;8661.177188167114;8888.688895888612;8974.955125224333;9247.213986811197;9345.48599827016;7787;7851.882221766564;8004.239597238253;8042.879356809535;8130.918690813016;8395.24442800151;8434.24091831738;8571.528565928684;8660.39377243587;8746.606402712021 00:41:22 INFO - PROCESS | 28930 | __end_tp_report 00:41:22 INFO - PROCESS | 28930 | __start_cc_report 00:41:22 INFO - PROCESS | 28930 | _x_x_mozilla_cycle_collect,965 00:41:22 INFO - PROCESS | 28930 | __end_cc_report 00:41:22 INFO - PROCESS | 28930 | __startTimestamp1461915682109__endTimestamp 00:41:22 INFO - PROCESS | 28930 | 00:41:22 INFO - PROCESS | 28930 | ------- Summary: start ------- 00:41:22 INFO - PROCESS | 28930 | Number of tests: 6 00:41:22 INFO - PROCESS | 28930 | 00:41:22 INFO - PROCESS | 28930 | [#0] dojo.html Cycles:165 Average:4615.90 Median:4738.57 stddev:473.37 (10.0%) stddev-sans-first:447.07 00:41:22 INFO - PROCESS | 28930 | Values: 2580.0 2675.8 2677.8 2686.8 2717.7 4601.4 4645.1 4647.6 4668.4 4734.7 4651.4 4686.8 4713.4 4721.6 4731.1 4233.9 4251.2 4281.5 4337.0 4457.9 4364.7 4401.1 4418.4 4426.0 4451.8 4219.9 4265.5 4333.0 4335.5 4354.9 4310.9 4339.3 4345.6 4361.3 4378.9 4185.5 4220.7 4243.4 4243.6 4277.2 4396.6 4450.1 4501.0 4514.6 4561.2 4958.3 4959.1 4969.8 4993.8 5018.5 4971.4 4975.5 4992.2 4995.3 4996.5 4578.3 4645.6 4658.8 4669.6 4747.3 5114.4 5128.4 5143.7 5165.1 5187.1 4909.8 4911.6 4913.4 4927.0 4960.3 4874.5 5008.4 5014.2 5023.3 5088.9 4858.7 4873.8 4874.6 4902.7 4932.7 4864.6 4865.9 4872.5 4889.8 4938.8 4137.3 4198.4 4201.5 4203.8 4236.7 3688.5 3706.3 3766.3 3803.6 3812.5 4261.6 4262.5 4270.5 4306.8 4312.0 4975.6 4981.0 4991.9 4995.2 5024.9 4138.8 4264.5 4314.1 4380.3 4390.6 4485.6 4487.5 4494.0 4499.5 4543.6 4727.0 4737.5 4738.6 4740.1 4744.4 4885.1 5027.2 5044.1 5096.5 5107.2 4689.8 4715.8 4721.8 4734.6 4783.8 4823.1 4924.3 4926.6 4935.8 4962.8 5030.1 5066.2 5080.6 5112.6 5139.0 4887.7 4893.3 4895.6 4900.3 4941.6 4711.6 4779.7 4896.0 4899.8 4945.0 4778.6 4789.0 4793.3 4793.6 4797.9 4888.0 4890.8 4892.1 4902.6 4935.9 4658.6 4741.8 4776.8 4805.6 4822.9 00:41:22 INFO - PROCESS | 28930 | 00:41:22 INFO - PROCESS | 28930 | [#1] ext.html Cycles:180 Average:41476.71 Median:174750.69 stddev:71719.74 (41.0%) stddev-sans-first:71855.21 00:41:22 INFO - PROCESS | 28930 | Values: 583.3 591.3 608.8 619.1 622.9 33850.5 35160.0 35207.1 35259.6 35301.0 37071.8 38103.0 38155.4 38158.4 38226.6 7648.1 7834.1 7836.1 7836.3 7837.3 7815.9 7965.9 7979.2 7981.1 7985.0 7956.6 8015.9 8031.3 8031.8 8037.4 7911.8 7964.5 7973.0 8007.8 8013.4 7595.9 7705.0 7705.7 7712.2 7720.0 38288.2 38670.0 38841.2 38857.6 38895.2 2927.2 3229.0 3385.6 3391.7 3482.4 28583.1 29002.4 29402.9 29851.0 30817.4 3277.8 3308.2 3316.4 3358.8 3426.0 242980.8 244317.0 244549.0 245134.0 246518.0 30162.1 52488.2 52812.5 52958.0 52972.7 31945.5 31956.7 31977.5 32000.2 32009.7 12962.7 13153.1 13177.9 13215.2 13227.4 10170.4 10206.2 10220.0 10225.9 10234.5 7892.5 8025.6 8103.5 8124.8 8175.4 3210.7 3216.0 3257.1 3300.3 3301.7 911.3 934.1 949.6 965.0 1060.2 28935.0 28969.3 28973.0 29217.3 29433.7 849.5 972.8 1006.5 1007.9 1021.3 13895.0 14699.2 14716.3 14874.2 14960.9 346019.0 349877.0 351039.0 351716.0 352267.0 47300.3 48927.3 49238.8 49289.5 49406.5 1199.5 1220.6 1258.9 1262.6 1275.6 25707.7 26530.3 27490.7 29031.6 29040.4 35704.6 35836.6 35850.8 35922.0 35925.8 202122.0 202380.0 202483.0 202559.0 202725.0 34220.7 34858.0 35128.6 35166.6 35612.3 38210.8 38271.4 38583.0 38853.4 39165.8 32263.8 32972.0 33188.8 33320.3 33413.2 33437.5 33521.0 33870.3 34193.7 35192.0 35353.0 35770.3 35935.0 36122.5 36311.8 31352.5 32045.5 32322.5 32396.4 32560.5 24698.4 24880.6 25319.7 25591.5 25629.9 00:41:22 INFO - PROCESS | 28930 | 00:41:22 INFO - PROCESS | 28930 | [#2] jquery.html Cycles:180 Average:24429.73 Median:394.64 stddev:67660.01 (17144.9%) stddev-sans-first:67825.72 00:41:22 INFO - PROCESS | 28930 | Values: 378.5 381.6 386.9 393.8 395.5 15694.2 16327.8 16938.7 17219.7 17255.8 15186.9 15577.5 15609.6 15638.0 15684.1 4984.2 5110.4 5141.7 5153.6 5154.8 3626.7 5525.7 5814.2 5824.4 5830.9 5754.2 5761.5 5787.2 5788.3 5794.0 5699.9 5848.4 5856.8 5873.0 5877.3 3345.5 3536.6 3541.1 3542.9 4916.3 19533.8 19776.3 20023.0 21006.0 21056.5 1924.7 1964.8 1983.3 2215.6 2509.9 12943.4 12996.4 13002.0 13059.8 13660.7 1759.5 1784.3 1821.3 1860.5 1881.5 61144.4 63835.0 64273.0 64903.4 65013.0 9433.6 9505.3 9716.4 9774.7 9863.1 13553.9 13637.2 13657.7 13682.5 13684.5 7245.1 7286.5 7292.0 7496.4 7500.4 7034.6 7039.5 7064.9 7141.5 7150.7 6088.4 6125.0 6197.6 6247.2 6300.1 1639.2 1695.9 1803.7 1834.3 1834.8 860.3 872.6 881.3 1018.2 1020.1 16506.5 17355.7 17374.4 17716.7 17830.4 906.4 957.9 963.5 983.6 1043.8 9941.5 9948.7 10144.7 10171.5 10197.8 399892.0 409999.0 414098.0 418032.0 419062.0 70535.6 73130.0 73805.3 74013.6 75339.0 961.5 968.2 984.7 991.9 998.5 15157.8 15357.0 15513.5 15542.8 15710.2 23477.9 32224.4 33153.5 33166.8 33222.8 43282.0 44046.6 44613.6 45305.8 45436.0 7715.3 7763.1 7799.6 7920.4 7969.9 6857.5 9266.7 11767.3 11815.9 12053.9 10051.1 10101.8 10258.6 10290.9 10325.4 9755.8 10038.5 10243.7 10350.9 10605.2 9878.4 10265.1 10281.9 10388.7 10523.5 7714.4 7800.5 7803.7 7804.5 7963.1 10443.4 10514.9 10516.2 10549.4 10618.0 00:41:22 INFO - PROCESS | 28930 | 00:41:22 INFO - PROCESS | 28930 | [#3] mootools.html Cycles:180 Average:5175.12 Median:5413.63 stddev:2893.29 (53.4%) stddev-sans-first:2886.63 00:41:22 INFO - PROCESS | 28930 | Values: 1284.2 1372.5 1426.5 1479.7 1741.2 6814.2 7647.5 7928.6 7934.6 7935.4 7686.2 7822.8 7824.1 7841.6 7842.6 2220.0 2250.3 2250.4 2253.4 2254.5 2199.5 2216.6 2275.8 2280.1 2291.2 2250.7 2259.4 2267.6 2268.2 2290.3 2146.5 2148.2 2149.3 2151.6 2154.6 2201.6 2215.1 2215.3 2217.2 2218.1 7591.8 7879.3 7928.3 8006.5 8007.0 4345.9 4437.5 4445.9 4451.7 4483.3 2912.5 2916.2 2924.2 2987.4 2993.5 925.9 933.1 944.1 945.2 945.9 10788.0 10934.8 10970.4 10989.2 10992.2 4038.7 4218.6 4234.1 4290.9 4294.7 8586.7 8616.4 8616.7 8632.5 8649.9 4565.5 4689.7 4710.4 4723.7 4724.0 3647.1 4103.4 4243.4 4246.9 4296.0 3479.2 3480.1 3558.7 3574.1 3603.9 1020.3 1057.1 1061.0 1067.0 1077.2 713.0 759.3 762.6 775.6 882.4 5256.2 5309.9 5344.1 5407.9 5473.9 889.3 901.2 910.0 913.2 930.3 3650.6 3787.3 3820.0 3837.7 3871.1 9505.9 9833.8 9933.2 9979.0 10116.8 9827.1 9847.2 9927.2 9943.1 10019.8 7046.6 7056.0 7233.9 7235.0 7253.1 5419.3 5480.5 5494.3 5498.6 5506.8 8740.3 8993.0 9017.9 9022.7 9036.0 8585.5 8833.3 8846.2 8896.9 8998.5 6234.8 6626.9 6819.7 6879.6 7024.5 7525.8 7529.3 7605.7 7622.8 7631.3 6664.9 6711.4 6874.0 6954.5 6984.6 6789.6 6837.0 6862.2 6905.6 6981.1 6137.5 6197.4 6208.2 6221.1 6447.9 4778.9 4779.6 4782.8 4852.9 4856.6 4714.9 4734.8 4766.9 4783.3 4855.1 00:41:22 INFO - PROCESS | 28930 | 00:41:22 INFO - PROCESS | 28930 | [#4] prototype.html Cycles:180 Average:4148.57 Median:4701.41 stddev:1185.63 (25.2%) stddev-sans-first:1153.52 00:41:22 INFO - PROCESS | 28930 | Values: 315.3 316.1 322.6 322.7 323.1 4595.3 4702.7 4719.5 4760.5 4767.1 4690.7 4692.4 4701.8 4702.9 4709.9 3558.0 3632.4 3692.5 3770.4 3792.7 3714.1 3757.2 3767.4 3773.1 3776.5 3527.7 3730.7 3736.7 3738.9 3745.7 3526.8 3673.7 3677.5 3680.8 3767.6 3348.2 3350.9 3358.3 3362.7 3371.2 4431.0 4446.7 4457.9 4463.4 4463.8 3974.8 4210.9 4221.3 4222.0 4233.3 4840.5 4893.9 4909.1 4912.6 4930.8 3542.0 3554.0 3573.4 3576.7 3588.6 5014.4 5081.4 5116.9 5120.9 5184.4 3633.7 3637.8 3640.6 3649.6 3671.9 3668.3 3683.3 3686.0 3689.9 3690.4 4179.1 4185.2 4190.9 4207.6 4214.4 4654.0 4904.9 4907.4 4912.8 4928.7 1335.4 1338.8 1338.9 1344.7 1350.4 882.5 904.9 912.8 917.6 919.8 4138.4 4242.5 4370.6 4406.8 4431.1 5112.6 5120.5 5131.6 5144.3 5161.4 4375.6 4412.3 4418.6 4420.7 4426.6 2825.1 2901.9 2912.3 2923.2 2925.5 5127.4 5131.6 5149.1 5149.2 5172.7 5002.8 5578.3 5580.2 5589.8 5607.3 4845.6 4859.3 4874.6 4877.4 4890.3 5103.4 5138.7 5163.7 5170.1 5176.2 4865.6 5039.5 5049.5 5053.4 5057.2 4838.4 4847.7 4852.2 4864.5 4892.8 3654.8 3682.4 3697.3 3708.9 3726.5 4921.4 5142.0 5151.5 5155.6 5168.6 4932.5 4974.5 4983.6 4983.8 5004.3 4955.6 4958.0 4969.8 4970.2 4994.2 4701.0 4870.5 4895.3 4901.5 4925.6 4648.0 4806.3 4937.3 4955.8 4970.4 4872.0 4873.6 4877.1 4898.5 4901.7 00:41:22 INFO - PROCESS | 28930 | 00:41:22 INFO - PROCESS | 28930 | [#5] yui.html Cycles:180 Average:12446.14 Median:599.77 stddev:14798.94 (2467.4%) stddev-sans-first:14813.71 00:41:22 INFO - PROCESS | 28930 | Values: 596.4 699.7 703.3 705.5 710.6 11444.7 11710.6 11931.0 11958.6 11969.2 10601.0 10674.1 10707.7 10758.4 10775.6 776.4 792.0 792.6 793.0 793.1 630.3 736.5 787.4 787.8 788.0 833.8 838.0 843.1 844.8 846.5 662.3 839.6 840.8 841.5 842.6 581.7 603.1 604.7 604.8 604.9 12216.6 12557.2 12573.4 12585.1 12599.7 11270.5 11778.0 12004.4 12212.6 12298.3 9738.9 9767.9 9927.7 9939.5 9996.9 3164.3 3179.1 3203.2 3254.2 3311.0 45150.5 45174.3 45704.8 45858.3 45959.8 9249.7 9452.7 9491.1 9558.9 9840.8 17083.9 17123.0 17125.4 17133.4 17186.8 6547.3 6643.9 6704.3 6715.9 6900.0 3510.0 3682.4 3821.0 3838.6 3882.2 2815.0 2842.3 2865.2 2868.1 2869.4 503.3 504.1 514.1 514.7 522.6 501.6 509.0 545.3 572.0 587.2 7245.5 7400.8 7537.8 7673.6 7680.9 498.9 585.5 593.3 629.1 638.7 3597.0 3668.7 3690.7 3703.6 3756.5 52170.0 53131.5 54039.2 54172.5 54185.0 46347.3 47186.8 48175.5 48758.5 49007.5 44204.6 44277.3 44415.3 44770.0 45210.5 7264.2 7345.3 7410.7 7445.4 7503.7 29659.0 29783.0 30302.4 30604.5 31087.4 35443.0 37658.0 39084.6 39223.8 39282.0 9294.0 9479.6 9514.0 9634.4 9663.0 9156.4 9268.8 9448.1 9569.0 10106.0 9205.4 9379.5 9594.8 9872.8 9929.1 8938.9 9118.5 9214.4 9389.3 9429.7 8661.2 8888.7 8975.0 9247.2 9345.5 7787.0 7851.9 8004.2 8042.9 8130.9 8395.2 8434.2 8571.5 8660.4 8746.6 00:41:22 INFO - PROCESS | 28930 | -------- Summary: end -------- 00:41:22 INFO - PROCESS | 28930 | 00:41:22 INFO - TEST-INFO | 28930: exit 0 00:41:22 INFO - TEST-OK | dromaeo_css | took 1119674ms 00:41:22 INFO - TEST-START | kraken 00:41:22 INFO - operating with platform_type : linux_ 00:41:22 INFO - Initialising browser for kraken test... 00:41:22 INFO - TEST-INFO | started process 29107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOCOs0/profile http://localhost:46296/getInfo.html) 00:41:27 INFO - PROCESS | 29107 | __metrics Screen width/height:1600/1200 00:41:27 INFO - PROCESS | 29107 | colorDepth:24 00:41:27 INFO - PROCESS | 29107 | Browser inner width/height: 1024/697 00:41:27 INFO - PROCESS | 29107 | __metrics 00:41:28 ERROR - PROCESS | 29107 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:41:29 INFO - TEST-INFO | 29107: exit 0 00:41:29 INFO - Browser initialized. 00:41:29 INFO - Running cycle 1/1 for kraken test... 00:41:29 INFO - TEST-INFO | started process 29186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOCOs0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:41:41 INFO - PROCESS | 29186 | RSS: Main: 156516352 00:41:41 INFO - PROCESS | 29186 | 00:41:43 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46296/tests/kraken/driver.html?testName=audio-beat-detection) 00:41:44 INFO - PROCESS | 29186 | RSS: Main: 210751488 00:41:44 INFO - PROCESS | 29186 | 00:41:47 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46296/tests/kraken/driver.html?testName=audio-dft) 00:41:48 INFO - PROCESS | 29186 | RSS: Main: 196497408 00:41:48 INFO - PROCESS | 29186 | 00:41:51 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46296/tests/kraken/driver.html?testName=audio-fft) 00:41:51 INFO - PROCESS | 29186 | RSS: Main: 267784192 00:41:51 INFO - PROCESS | 29186 | 00:41:54 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46296/tests/kraken/driver.html?testName=audio-oscillator) 00:41:54 INFO - PROCESS | 29186 | RSS: Main: 175800320 00:41:54 INFO - PROCESS | 29186 | 00:41:56 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:41:57 INFO - PROCESS | 29186 | RSS: Main: 180219904 00:41:57 INFO - PROCESS | 29186 | 00:42:00 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46296/tests/kraken/driver.html?testName=imaging-darkroom) 00:42:01 INFO - PROCESS | 29186 | RSS: Main: 215662592 00:42:01 INFO - PROCESS | 29186 | 00:42:04 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46296/tests/kraken/driver.html?testName=imaging-desaturate) 00:42:05 INFO - PROCESS | 29186 | RSS: Main: 216600576 00:42:05 INFO - PROCESS | 29186 | 00:42:08 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46296/tests/kraken/driver.html?testName=json-parse-financial) 00:42:08 INFO - PROCESS | 29186 | RSS: Main: 216629248 00:42:08 INFO - PROCESS | 29186 | 00:42:10 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:42:11 INFO - PROCESS | 29186 | RSS: Main: 203538432 00:42:11 INFO - PROCESS | 29186 | 00:42:12 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:42:13 INFO - PROCESS | 29186 | RSS: Main: 209260544 00:42:13 INFO - PROCESS | 29186 | 00:42:15 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:42:16 INFO - PROCESS | 29186 | RSS: Main: 218427392 00:42:16 INFO - PROCESS | 29186 | 00:42:19 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:42:19 INFO - PROCESS | 29186 | RSS: Main: 226885632 00:42:19 INFO - PROCESS | 29186 | 00:42:22 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:42:23 INFO - PROCESS | 29186 | RSS: Main: 222134272 00:42:23 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | Cycle 1(1): loaded http://localhost:46296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46296/tests/kraken/driver.html?testName=ai-astar) 00:42:25 INFO - PROCESS | 29186 | RSS: Main: 286560256 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | __start_tp_report 00:42:25 INFO - PROCESS | 29186 | _x_x_mozilla_page_load 00:42:25 INFO - PROCESS | 29186 | _x_x_mozilla_page_load_details 00:42:25 INFO - PROCESS | 29186 | |i|pagename|runs| 00:42:25 INFO - PROCESS | 29186 | |0;ai-astar;114;113;110;114;114;114;102;111;111;113 00:42:25 INFO - PROCESS | 29186 | |1;audio-beat-detection;163;130;159;183;132;156;158;132;189;136 00:42:25 INFO - PROCESS | 29186 | |2;audio-dft;161;161;161;162;162;161;161;163;167;163 00:42:25 INFO - PROCESS | 29186 | |3;audio-fft;74;77;126;104;73;74;73;126;103;74 00:42:25 INFO - PROCESS | 29186 | |4;audio-oscillator;94;94;149;94;93;94;143;94;94;140 00:42:25 INFO - PROCESS | 29186 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;116;117;117 00:42:25 INFO - PROCESS | 29186 | |6;imaging-darkroom;148;147;147;146;146;147;146;146;146;145 00:42:25 INFO - PROCESS | 29186 | |7;imaging-desaturate;95;94;95;95;95;95;94;95;95;95 00:42:25 INFO - PROCESS | 29186 | |8;json-parse-financial;65;65;64;64;64;64;66;80;62;62 00:42:25 INFO - PROCESS | 29186 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;65;65;64 00:42:25 INFO - PROCESS | 29186 | |10;stanford-crypto-aes;78;77;77;77;78;79;81;78;80;79 00:42:25 INFO - PROCESS | 29186 | |11;stanford-crypto-ccm;136;138;132;127;130;129;128;129;163;129 00:42:25 INFO - PROCESS | 29186 | |12;stanford-crypto-pbkdf2;180;174;179;185;179;173;175;178;172;173 00:42:25 INFO - PROCESS | 29186 | |13;stanford-crypto-sha256-iterative;74;73;76;72;70;70;71;73;71;77 00:42:25 INFO - PROCESS | 29186 | __end_tp_report 00:42:25 INFO - PROCESS | 29186 | __start_cc_report 00:42:25 INFO - PROCESS | 29186 | _x_x_mozilla_cycle_collect,1938 00:42:25 INFO - PROCESS | 29186 | __end_cc_report 00:42:25 INFO - PROCESS | 29186 | __startTimestamp1461915745396__endTimestamp 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | ------- Summary: start ------- 00:42:25 INFO - PROCESS | 29186 | Number of tests: 14 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.50 stddev:3.69 (3.2%) stddev-sans-first:3.81 00:42:25 INFO - PROCESS | 29186 | Values: 114.0 113.0 110.0 114.0 114.0 114.0 102.0 111.0 111.0 113.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:158.50 stddev:21.24 (13.4%) stddev-sans-first:22.26 00:42:25 INFO - PROCESS | 29186 | Values: 163.0 130.0 159.0 183.0 132.0 156.0 158.0 132.0 189.0 136.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.87 (1.2%) stddev-sans-first:1.94 00:42:25 INFO - PROCESS | 29186 | Values: 161.0 161.0 161.0 162.0 162.0 161.0 161.0 163.0 167.0 163.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#3] audio-fft Cycles:10 Average:90.40 Median:73.50 stddev:22.29 (30.3%) stddev-sans-first:22.84 00:42:25 INFO - PROCESS | 29186 | Values: 74.0 77.0 126.0 104.0 73.0 74.0 73.0 126.0 103.0 74.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:94.00 stddev:24.32 (25.9%) stddev-sans-first:25.19 00:42:25 INFO - PROCESS | 29186 | Values: 94.0 94.0 149.0 94.0 93.0 94.0 143.0 94.0 94.0 140.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 00:42:25 INFO - PROCESS | 29186 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 00:42:25 INFO - PROCESS | 29186 | Values: 148.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:42:25 INFO - PROCESS | 29186 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:64.50 stddev:5.21 (8.1%) stddev-sans-first:5.52 00:42:25 INFO - PROCESS | 29186 | Values: 65.0 65.0 64.0 64.0 64.0 64.0 66.0 80.0 62.0 62.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 00:42:25 INFO - PROCESS | 29186 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 64.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.50 stddev:1.35 (1.7%) stddev-sans-first:1.42 00:42:25 INFO - PROCESS | 29186 | Values: 78.0 77.0 77.0 77.0 78.0 79.0 81.0 78.0 80.0 79.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:131.00 stddev:10.75 (8.2%) stddev-sans-first:11.38 00:42:25 INFO - PROCESS | 29186 | Values: 136.0 138.0 132.0 127.0 130.0 129.0 128.0 129.0 163.0 129.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:178.50 stddev:4.10 (2.3%) stddev-sans-first:4.19 00:42:25 INFO - PROCESS | 29186 | Values: 180.0 174.0 179.0 185.0 179.0 173.0 175.0 178.0 172.0 173.0 00:42:25 INFO - PROCESS | 29186 | 00:42:25 INFO - PROCESS | 29186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:2.41 (3.3%) stddev-sans-first:2.51 00:42:25 INFO - PROCESS | 29186 | Values: 74.0 73.0 76.0 72.0 70.0 70.0 71.0 73.0 71.0 77.0 00:42:25 INFO - PROCESS | 29186 | -------- Summary: end -------- 00:42:25 INFO - PROCESS | 29186 | 00:42:26 INFO - TEST-INFO | 29186: exit 0 00:42:26 INFO - TEST-OK | kraken | took 63472ms 00:42:26 INFO - SUITE-END | took 1183s 00:42:26 INFO - Completed test suite (00:19:43) 00:42:26 INFO - javascript benchmark 00:42:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2579.9999999999995, 2675.839449633021, 2677.8342567816253, 2686.7716244119247, 2717.687465941416, 4601.447826260845, 4645.117427688737, 4647.628189744821, 4668.439787225533, 4734.7159170449795, 4651.418572678415, 4686.812527498896, 4713.434387873452, 4721.645876559263, 4731.101090792756, 4233.894152646178, 4251.171021650764, 4281.464816897887, 4337.04584991303, 4457.910841783162, 4364.738115713068, 4401.0977749561425, 4418.359337896003, 4426.026274219666, 4451.777411129447, 4219.873403797891, 4265.466816647919, 4333.025069359401, 4335.501417336984, 4354.869353919387, 4310.935335969963, 4339.262325404688, 4345.565443455661, 4361.3457981302745, 4378.934315985262, 4185.455890734185, 4220.704550681454, 4243.384709217177, 4243.575642435762, 4277.230098582254, 4396.56034396561, 4450.10997800438, 4500.954990450086, 4514.616257618107, 4561.156186105548, 4958.281049247839, 4959.082569724613, 4969.82605608802, 4993.800247990076, 5018.498150184989, 4971.428285747149, 4975.527324904128, 4992.176290911995, 4995.300657907896, 4996.475370086161, 4578.313253012075, 4645.605123564501, 4658.836940707059, 4669.649776266726, 4747.311639812277, 5114.41184263807, 5128.410232823198, 5143.71709555978, 5165.1219292720325, 5187.118189907725, 4909.828156014522, 4911.582515486152, 4913.361263035782, 4926.975365123151, 4960.330355402047, 4874.488178741252, 5008.424031236382, 5014.222795466709, 5023.271625614266, 5088.949110508922, 4858.708477491362, 4873.756312184377, 4874.610031197496, 4902.730349830794, 4932.728699921467, 4864.610831133572, 4865.854024379274, 4872.4640289568115, 4889.804407823718, 4938.75306234694, 4137.338025915839, 4198.3702444633545, 4201.537830838605, 4203.76879271643, 4236.703430759817, 3688.4651725499652, 3706.29580379727, 3766.265578212277, 3803.581606023335, 3812.4662547243406, 4261.616454519108, 4262.488501379854, 4270.530241673413, 4306.82772689089, 4311.956880431218, 4975.601951843843, 4980.950190498049, 4991.850244492671, 4995.175795993693, 5024.899502009939, 4138.772367519755, 4264.466941632296, 4314.09404025152, 4380.255356589388, 4390.5828946250695, 4485.551444855489, 4487.461504619467, 4493.955060449419, 4499.52754960731, 4543.591076803037, 4726.976365118221, 4737.45519265282, 4738.573528382462, 4740.1230772307235, 4744.383230180055, 4885.1450996076255, 5027.170516864677, 5044.117279476003, 5096.490350964874, 5107.233914912793, 4689.812407503661, 4715.78778954941, 4721.811127554859, 4734.621230301636, 4783.760811959458, 4823.107725070873, 4924.285978533164, 4926.605871530197, 4935.75321233944, 4962.751862406937, 5030.144875371123, 5066.240063990431, 5080.644354895122, 5112.6165537585575, 5139.023585518739, 4887.682300650446, 4893.339399181065, 4895.632827537877, 4900.26496025599, 4941.579965702812, 4711.575958163782, 4779.665423420327, 4895.951040489549, 4899.755012249302, 4945.035718034948, 4778.617710583076, 4788.976055119702, 4793.304970779287, 4793.616510679068, 4797.880052998703, 4887.951120488749, 4890.755462226945, 4892.143874821963, 4902.63230257725, 4935.851924442272, 4658.604018658452, 4741.83403580873, 4776.761161941959, 4805.591524720298, 4822.927656085091], "value": 4586.712443507573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.2621733507115, 591.2638764737901, 608.8295277322349, 619.1393962392276, 622.85985653228, 33850.49224261635, 35160.0, 35207.11982200446, 35259.64740352596, 35301.0, 37071.81464092682, 38103.0, 38155.427668584925, 38158.42762358567, 38226.617733822655, 7648.0822301323915, 7834.138244793068, 7836.138024817265, 7836.255555722198, 7837.333826624744, 7815.882761758578, 7965.8805117923275, 7979.162187970267, 7981.1220765715725, 7984.960075199616, 7956.641951112185, 8015.879761803549, 8031.277185053344, 8031.839363212733, 8037.437379383446, 7911.8417631647335, 7964.482308649919, 7972.960135199345, 8007.759767206993, 8013.439059265825, 7595.924040759577, 7704.961475192588, 7705.6917723291, 7712.190220026872, 7720.0, 38288.23423531514, 38670.0, 38841.22317553633, 38857.611423885966, 38895.22209555793, 2927.238917881345, 3228.983855080733, 3385.64450732672, 3391.71170450512, 3482.373172828915, 28583.142505724652, 29002.41995160085, 29402.852985734935, 29851.0, 30817.38365232705, 3277.8033318000757, 3308.17295676081, 3316.3864685033104, 3358.8320583970703, 3426.0407086015957, 242980.78509607515, 244317.0, 244549.0, 245134.0, 246518.0, 30162.09513714592, 52488.212676809875, 52812.471875281524, 52958.0, 52972.735136324074, 31945.52081718776, 31956.680433195834, 31977.52033719496, 32000.199994999846, 32009.67990320067, 12962.740745185043, 13153.079284449997, 13177.868221317663, 13215.207087574776, 13227.404766785517, 10170.440625765506, 10206.234532410099, 10220.02909723575, 10225.897741022494, 10234.48827558619, 7892.526448412998, 8025.638846251933, 8103.513789172668, 8124.7562573122905, 8175.386845986574, 3210.7110360067704, 3215.9839200803845, 3257.1042963185314, 3300.3069355435146, 3301.7028467437567, 911.3301723233418, 934.0845970948372, 949.6154057606681, 964.9758756031156, 1060.188955449082, 28935.0, 28969.275768105967, 28973.0, 29217.269568260963, 29433.705662943525, 849.5370023337173, 972.7713987212999, 1006.5219020965129, 1007.8740157480315, 1021.3157184686278, 13895.0, 14699.207150641343, 14716.264186790617, 14874.181919994287, 14960.925195373953, 346019.0, 349877.0, 351039.0, 351716.0, 352267.0, 47300.29049564259, 48927.26609100866, 49238.75380623074, 49289.50710492921, 49406.50593494091, 1199.4662375242933, 1220.6277085489012, 1258.9496420143275, 1262.5896583610363, 1275.6173148055545, 25707.742922570535, 26530.336741581614, 27490.725092749617, 29031.564526531696, 29040.41919161647, 35704.64295357013, 35836.641633584375, 35850.820745896104, 35922.0, 35925.82037089798, 202122.0, 202380.0, 202483.0, 202559.0, 202725.0, 34220.65779342175, 34858.0, 35128.648713512535, 35166.64833351736, 35612.28775424425, 38210.8089459562, 38271.42592861165, 38583.0, 38853.41719874261, 39165.804170980104, 32263.838680807385, 32972.0, 33188.834055830535, 33320.333593327516, 33413.16467088342, 33437.498437523944, 33521.0, 33870.3225935475, 34193.65806341905, 35192.0, 35353.0, 35770.28459430745, 35935.0, 36122.45816312705, 36311.81844090763, 31352.52971205388, 32045.519317209793, 32322.515162273055, 32396.35207295888, 32560.51159232661, 24698.382540435912, 24880.62679059852, 25319.746802532474, 25591.48817023612, 25629.871850640626], "value": 16143.076948299937, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.5495211150363, 381.63553806115164, 386.92841824262507, 393.8090026337228, 395.46217144683226, 15694.215289235535, 16327.83672163281, 16938.661226775457, 17219.655606887885, 17255.827441725596, 15186.924065379686, 15577.532674019798, 15609.609759756011, 15638.0, 15684.137372444511, 4984.177610694231, 5110.361204849394, 5141.665791723526, 5153.56194723449, 5154.845354639348, 3626.655467730561, 5525.723713814314, 5814.24414826072, 5824.359320474744, 5830.941690583103, 5754.1944127822135, 5761.510271626917, 5787.189793428924, 5788.305403351604, 5794.043982742843, 5699.886002279952, 5848.356680765112, 5856.824295271127, 5873.0, 5877.265341832271, 3345.4814503751713, 3536.5756109266795, 3541.0970202598173, 3542.9114272143147, 4916.311716359713, 19533.80466195334, 19776.30782922605, 20023.0, 21006.0, 21056.473588160265, 1924.6824273994773, 1964.842812575005, 1983.2562788954142, 2215.556888622266, 2509.912153074634, 12943.352832358345, 12996.350182490838, 13002.0, 13059.804102938464, 13660.726785464334, 1759.463363674079, 1784.3219576560953, 1821.2532861526843, 1860.5441666791723, 1881.5296175956012, 61144.38855611432, 63835.0, 64273.0, 64903.350966490674, 65013.0, 9433.6415896026, 9505.287103467268, 9716.417014978982, 9774.657886973922, 9863.112319891245, 13553.932230338785, 13637.181769093886, 13657.658558536115, 13682.452701892013, 13684.52104176369, 7245.058142441554, 7286.453515986323, 7291.963540182265, 7496.437767167376, 7500.399968002546, 7034.577925324497, 7039.472039597051, 7064.858702825914, 7141.500094993301, 7150.7497237596435, 6088.360722124113, 6124.969375153096, 6197.628142311476, 6247.187865577536, 6300.086487459384, 1639.2459468644556, 1695.940642077546, 1803.6843552378282, 1834.339637730416, 1834.7711013601606, 860.2730692564772, 872.5506364222431, 881.2685471059006, 1018.1905385218769, 1020.0768304684273, 16506.516649777986, 17355.65288694219, 17374.39189628357, 17716.734248986275, 17830.37593684215, 906.410832958569, 957.899420560845, 963.4893506441597, 983.5868935047297, 1043.7651528406047, 9941.45322007282, 9948.701538953697, 10144.746381340377, 10171.4914254287, 10197.847032294521, 399892.0, 409999.0, 414098.0, 418032.0, 419062.0, 70535.64732176409, 73130.0, 73805.26194738092, 74013.62993185, 75339.0, 961.4567769210514, 968.2496065549255, 984.7291994701371, 991.9008099190168, 998.5406712912142, 15157.772633410286, 15357.0, 15513.534593962198, 15542.766858496905, 15710.214489275262, 23477.88261058752, 32224.355512889142, 33153.50269745907, 33166.834165829016, 33222.83720069786, 43282.0, 44046.559534404245, 44613.55386446094, 45305.77347113243, 45436.0, 7715.27874877647, 7763.0684317882215, 7799.610019499116, 7920.405969552191, 7969.880451793112, 6857.485688573277, 9266.702661627512, 11767.293962362286, 11815.940920295343, 12053.879461205626, 10051.095401413908, 10101.797964040825, 10258.640947566799, 10290.897091029294, 10325.380477171393, 9755.756106097404, 10038.548265328223, 10243.7439064024, 10350.896491034993, 10605.151587873106, 9878.407295562289, 10265.12746416563, 10281.9485902573, 10388.688339349832, 10523.473826308807, 7714.382849372149, 7800.531968081933, 7803.7268695595385, 7804.531728096333, 7963.124056353912, 10443.425611591436, 10514.947425262824, 10516.211284153565, 10549.367037977747, 10618.0], "value": 8301.70756851009, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.2487145020164, 1372.4921778941793, 1426.4579459805275, 1479.7262506436302, 1741.164241164241, 6814.182298124226, 7647.541147531145, 7928.563928983904, 7934.642941067651, 7935.365170786337, 7686.154523002479, 7822.843543129148, 7824.100228473713, 7841.647125879334, 7842.647080881374, 2220.04538048639, 2250.336150835499, 2250.4148921280503, 2253.43664083979, 2254.5040091179912, 2199.52710167314, 2216.601011817872, 2275.8065564427043, 2280.0879648140713, 2291.1522736587403, 2250.651149071888, 2259.423846919033, 2267.6031694453486, 2268.160780511205, 2290.278562252893, 2146.51703366742, 2148.194427089841, 2149.3337065509663, 2151.612709712251, 2154.622940985329, 2201.570693714726, 2215.069670738294, 2215.3353993801957, 2217.2128894242474, 2218.057325636598, 7591.772246832548, 7879.251471110236, 7928.286454219148, 8006.519608823431, 8007.0, 4345.891352716176, 4437.511873693891, 4445.866624001285, 4451.666125040602, 4483.282674772021, 2912.504874171396, 2916.2271997920566, 2924.1958461423064, 2987.4323878463024, 2993.491106511898, 925.8842644669417, 933.0809152984305, 944.0936700767272, 945.2107490245653, 945.8770359853175, 10788.0, 10934.835977460423, 10970.396628185446, 10989.230753847234, 10992.230543861933, 4038.7374820636564, 4218.620324170778, 4234.089670720809, 4290.871273861789, 4294.742315461082, 8586.65653373858, 8616.353773467015, 8616.655333786579, 8632.48205107683, 8649.91350086491, 4565.474970378449, 4689.710329659371, 4710.36410084641, 4723.6929599575915, 4724.031573527419, 3647.0699971507624, 4103.4460347853255, 4243.405923170759, 4246.915061698749, 4295.957040429618, 3479.2171761353998, 3480.060383696388, 3558.733095017884, 3574.070741607201, 3603.94594081089, 1020.3163880200284, 1057.138432177788, 1061.0397590180899, 1067.0, 1077.2405454154803, 713.0267185292039, 759.2748924776824, 762.6301243896705, 775.6354513378703, 882.4484697064335, 5256.237845512379, 5309.946900530946, 5344.118220493575, 5407.918881216785, 5473.890522189534, 889.3463304471209, 901.1664210605164, 909.9954500227457, 913.1918252346721, 930.2929773372285, 3650.634936506381, 3787.337215987191, 3820.025893397166, 3837.654611085016, 3871.1483473635753, 9505.857412138823, 9833.754156146011, 9933.155681766986, 9979.0, 10116.797664046679, 9827.066428689262, 9847.16299114569, 9927.15619172364, 9943.055409736064, 10019.79960400788, 7046.577205367695, 7056.012158297843, 7233.8553228935125, 7234.96382518084, 7253.129624444995, 5419.34967803866, 5480.506754392124, 5494.313210848644, 5498.560115190695, 5506.80726174598, 8740.257078148428, 8992.955035224782, 9017.864732028893, 9022.684206052756, 9036.0, 8585.527795971282, 8833.337499687677, 8846.248068913957, 8896.911030889867, 8998.505082220541, 6234.844128896814, 6626.867462650816, 6819.727210911508, 6879.6216208107035, 7024.5434046786795, 7525.849483010418, 7529.322360987538, 7605.6577454015805, 7622.771316860503, 7631.275028872248, 6664.933350666432, 6711.362420570038, 6874.0, 6954.513184077066, 6984.615846128511, 6789.592624442549, 6836.965815170893, 6862.245153033262, 6905.620190889549, 6981.057557229709, 6137.478314343331, 6197.380261973766, 6208.192934918612, 6221.129041934042, 6447.903281450688, 4778.856634300976, 4779.641526885428, 4782.832600858953, 4852.8544143675745, 4856.587190088882, 4714.858554243378, 4734.786934587883, 4766.928496072631, 4783.258594917794, 4855.101806165871], "value": 4162.4953895285125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.2827317851888, 316.10699773140874, 322.6193092151262, 322.6821580742969, 323.0743918673003, 4595.264757638778, 4702.694324868886, 4719.457262414823, 4760.523947605234, 4767.118083154619, 4690.718556886589, 4692.389989301395, 4701.835435759749, 4702.882427939303, 4709.882252943669, 3557.9822100889523, 3632.418812989922, 3692.504535663061, 3770.415585584225, 3792.677622402099, 3714.1086139326635, 3757.2384297541284, 3767.3972164453694, 3773.113318370181, 3776.5271544097823, 3527.682508574228, 3730.716969067217, 3736.6637002669754, 3738.9252214955686, 3745.6816170625393, 3526.818515797211, 3673.687736542397, 3677.5219221501166, 3680.815959202056, 3767.6232376762377, 3348.2131699050706, 3350.8659653613827, 3358.2779702363864, 3362.747793915466, 3371.174062354739, 4430.977845110786, 4446.666500012479, 4457.888552786174, 4463.4420697412825, 4463.839401755535, 3974.8012599369918, 4210.873673789792, 4221.324588065925, 4222.0, 4233.322668373045, 4840.467548569654, 4893.8711660427825, 4909.140900342426, 4912.582430493412, 4930.802767889316, 3542.025942865707, 3554.0048786339867, 3573.446115852047, 3576.7138628909624, 3588.5693716753894, 5014.398272207359, 5081.441041485434, 5116.948830511685, 5120.948790512047, 5184.351956005499, 3633.745637805381, 3637.8181090945345, 3640.5983696277126, 3649.61679023704, 3671.908202294964, 3668.3396988541786, 3683.3185860615336, 3685.981570092132, 3689.8893033209047, 3690.4464330350124, 4179.101493178981, 4185.162967406531, 4190.937135942963, 4207.600277973587, 4214.3889136075095, 4654.0, 4904.8773780655765, 4907.386576677915, 4912.803487860517, 4928.704277743347, 1335.3657012918786, 1338.805873148388, 1338.9263590502617, 1344.6889282949046, 1350.4125705318218, 882.4749274181852, 904.8959369672572, 912.8493798523302, 917.6100157433065, 919.8482250428605, 4138.379243113557, 4242.469691288589, 4370.562943705668, 4406.845760398371, 4431.135928493913, 5112.565431938327, 5120.48795120485, 5131.5638170755155, 5144.331236939249, 5161.406438259573, 4375.584319489643, 4412.294032954712, 4418.646508279394, 4420.668449866273, 4426.557344265548, 2825.138332808472, 2901.854907254629, 2912.3010477485673, 2923.2399576110365, 2925.502664547032, 5127.435982041972, 5131.5638170755155, 5149.116494762945, 5149.227615857576, 5172.741362931838, 5002.799888004512, 5578.330600327987, 5580.246666700024, 5589.832305030855, 5607.299087614048, 4845.6123510119105, 4859.31969524274, 4874.5856602188505, 4877.3903262092235, 4890.266460030953, 5103.362079740033, 5138.717370544507, 5163.715995620277, 5170.146925757208, 5176.197689358005, 4865.610751139971, 5039.521245481674, 5049.495050495068, 5053.36832895888, 5057.154138739407, 4838.443578988461, 4847.709137451764, 4852.1508735971765, 4864.537868902448, 4892.804287828447, 3654.8355324011013, 3682.3671075181373, 3697.3344797935556, 3708.925821483609, 3726.4969229154804, 4921.434035086011, 5142.0, 5151.484851514819, 5155.613329000265, 5168.58651307902, 4932.495588845437, 4974.527419895104, 4983.5763960063805, 4983.825566105169, 5004.3494345734825, 4955.55400013986, 4957.975210123926, 4969.776360063878, 4970.204767237369, 4994.1759609663995, 4700.976495117503, 4870.512948705101, 4895.265710143507, 4901.534354236342, 4925.605951523941, 4647.977444962103, 4806.303086052572, 4937.308776771327, 4955.752212389438, 4970.353853998957, 4872.049950259665, 4873.561379475864, 4877.12211801879, 4898.485659005753, 4901.705897646153], "value": 3785.5495006964197, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.439347013807, 699.6711545573579, 703.3283214530124, 705.4708968273794, 710.6340234779088, 11444.656660300183, 11710.590129345475, 11931.0, 11958.64124076279, 11969.222000569956, 10601.04590586849, 10674.146068314536, 10707.678769636905, 10758.408287544202, 10775.56897724092, 776.3711393771049, 791.9941674073951, 792.6076592086926, 792.9801754956114, 793.1275596843484, 630.3444417805476, 736.5028605691137, 787.3779714025912, 787.7833595761183, 787.9960600196991, 833.7582101190648, 838.0446291228005, 843.1357858195369, 844.8394804987064, 846.4667259626458, 662.3145044878576, 839.6263662670115, 840.7519781664423, 841.5497708725833, 842.6418772021897, 581.7469400810661, 603.1043899808824, 604.6976511744128, 604.7762327938647, 604.8518113062283, 12216.633500994983, 12557.183783054072, 12573.37133143339, 12585.056120790885, 12599.685007874876, 11270.54917803295, 11778.0, 12004.399780011052, 12212.633620991384, 12298.323592202425, 9738.90261097394, 9767.902320976771, 9927.702168934944, 9939.50302484873, 9996.850047249298, 3164.3196712706876, 3179.0780673604627, 3203.2312245061016, 3254.1864533866533, 3311.0397984584683, 45150.548494514966, 45174.32238516425, 45704.77147614274, 45858.312125318145, 45959.77020114911, 9249.676261330822, 9452.716418507456, 9491.145796878314, 9558.856617150748, 9840.803183936425, 17083.914580427267, 17123.0, 17125.400610978555, 17133.400330988356, 17186.82813171852, 6547.279799222082, 6643.900341494881, 6704.3295670433545, 6715.865682686416, 6899.999500072461, 3510.014363230139, 3682.3739964206147, 3821.0, 3838.6353296436796, 3882.2041481496226, 2815.0, 2842.332051967786, 2865.1834227245135, 2868.096549586915, 2869.368738877444, 503.26523276017423, 504.1144636370434, 514.0567059445958, 514.7374838832222, 522.5767128625826, 501.6237821633775, 509.0, 545.3374150407274, 572.044685375424, 587.1984740828738, 7245.529040612449, 7400.814979625445, 7537.8115547110665, 7673.616319184019, 7680.884786728204, 498.9376327959005, 585.4759989809182, 593.3058321763547, 629.1380808292669, 638.6811234800123, 3597.0, 3668.669819716238, 3690.6678398944223, 3703.5555733311635, 3756.4740936268945, 52170.0, 53131.468685313426, 54039.18941215885, 54172.45827541753, 54185.0, 46347.30479042817, 47186.76406617945, 48175.5182448171, 48758.51241487611, 49007.50992490101, 44204.557954420045, 44277.33583996243, 44415.33376999348, 44770.0, 45210.547894520634, 7264.23725508814, 7345.3021962913435, 7410.740624078131, 7445.4415918805225, 7503.662335195038, 29659.0, 29783.0, 30302.393952121274, 30604.540931885593, 31087.378252435275, 35443.0, 37658.0, 39084.60915390924, 39223.80388098041, 39282.0, 9293.953530232306, 9479.620815167316, 9513.952430237805, 9634.362158433223, 9662.951685241529, 9156.404833685789, 9268.814623707623, 9448.149666530046, 9568.95215523918, 10106.0, 9205.355625106178, 9379.484128373006, 9594.760130996781, 9872.802543949225, 9929.056739609725, 8938.86591701112, 9118.498482583522, 9214.44713317203, 9389.342746007987, 9429.717108486757, 8661.177188167114, 8888.688895888612, 8974.955125224333, 9247.213986811197, 9345.48599827016, 7787.0, 7851.882221766564, 8004.239597238253, 8042.879356809535, 8130.918690813016, 8395.24442800151, 8434.24091831738, 8571.528565928684, 8660.39377243587, 8746.606402712021], "value": 5644.7552193159845, "unit": "score"}], "name": "dromaeo_css", "value": 6160.817341590869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 110.0, 114.0, 114.0, 114.0, 102.0, 111.0, 111.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 130.0, 159.0, 183.0, 132.0, 156.0, 158.0, 132.0, 189.0, 136.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 163.0, 167.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 126.0, 104.0, 73.0, 74.0, 73.0, 126.0, 103.0, 74.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 149.0, 94.0, 93.0, 94.0, 143.0, 94.0, 94.0, 140.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 64.0, 66.0, 80.0, 62.0, 62.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 77.0, 78.0, 79.0, 81.0, 78.0, 80.0, 79.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 132.0, 127.0, 130.0, 129.0, 128.0, 129.0, 163.0, 129.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 174.0, 179.0, 185.0, 179.0, 173.0, 175.0, 178.0, 172.0, 173.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 72.0, 70.0, 70.0, 71.0, 73.0, 71.0, 77.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1576.6999999999998, "alertThreshold": 2.0}]} 00:42:26 INFO - Return code: 0 00:42:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:42:26 ERROR - # TBPL SUCCESS # 00:42:26 INFO - Running post-action listener: _resource_record_post_action 00:42:26 INFO - Running post-run listener: _resource_record_post_run 00:42:27 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 517939200; Read time: 336; Write time: 858072 00:42:27 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 234627072; Read time: 0; Write time: 464572 00:42:27 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283312128; Read time: 336; Write time: 393500 00:42:27 INFO - Running post-run listener: _upload_blobber_files 00:42:27 INFO - Blob upload gear active. 00:42:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:42:27 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 00:42:27 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'] 00:42:27 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 00:42:28 INFO - (blobuploader) - INFO - Open directory for files ... 00:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:42:28 INFO - (blobuploader) - INFO - Done attempting. 00:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:42:29 INFO - (blobuploader) - INFO - Done attempting. 00:42:29 INFO - (blobuploader) - INFO - Iteration through files over. 00:42:29 INFO - Return code: 0 00:42:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:42:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:42:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/715123b802946e6a97740a73800f1122118341bb589fc499fbecbdcd8d84859090b3dfd66840b2619720d7b9c646a37fa0320aebdbf183d41634665156208c59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36beb4fcd5751fa94b0b831fa83aefa9d3babe9d360ffd75a024391f0a2e2818044feb4639571d647ac3c3fe5471e378bb8d4d0dcfbbadc8f8e992cbc02c36eb"} 00:42:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:42:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:42:29 INFO - Contents: 00:42:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/715123b802946e6a97740a73800f1122118341bb589fc499fbecbdcd8d84859090b3dfd66840b2619720d7b9c646a37fa0320aebdbf183d41634665156208c59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36beb4fcd5751fa94b0b831fa83aefa9d3babe9d360ffd75a024391f0a2e2818044feb4639571d647ac3c3fe5471e378bb8d4d0dcfbbadc8f8e992cbc02c36eb"} 00:42:29 INFO - Running post-run listener: copy_logs_to_upload_dir 00:42:29 INFO - Copying logs to upload dir... 00:42:29 INFO - mkdir: /builds/slave/test/build/upload/logs 00:42:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.522300 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-29 00:42:29.208569) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 00:42:29.213166) ========= 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=aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479 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/715123b802946e6a97740a73800f1122118341bb589fc499fbecbdcd8d84859090b3dfd66840b2619720d7b9c646a37fa0320aebdbf183d41634665156208c59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36beb4fcd5751fa94b0b831fa83aefa9d3babe9d360ffd75a024391f0a2e2818044feb4639571d647ac3c3fe5471e378bb8d4d0dcfbbadc8f8e992cbc02c36eb"} build_url:https://queue.taskcluster.net/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/JraHqmsFTFuVKg0Q9u0HkQ/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/715123b802946e6a97740a73800f1122118341bb589fc499fbecbdcd8d84859090b3dfd66840b2619720d7b9c646a37fa0320aebdbf183d41634665156208c59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36beb4fcd5751fa94b0b831fa83aefa9d3babe9d360ffd75a024391f0a2e2818044feb4639571d647ac3c3fe5471e378bb8d4d0dcfbbadc8f8e992cbc02c36eb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 00:42:29.242341) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 00:42:29.242671) ========= 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=aa52b8aba932b19cc50b5275000001de-1461914247.155293-649240479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 00:42:29.323622) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 00:42:29.327029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 00:42:29.327378) ========= ========= Total master_lag: 0.19 =========