builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1460677996.36 results: success (0) buildid: 20160414161850 builduid: 3e25626c57874c75bbb1991d4b470452 revision: 8cbd3940c47f0babdf44937b799e160278b4a1fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:16.359970) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:16.360475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:16.360764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:16.376792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:16.377068) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 16:53:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 139M=0s 2016-04-14 16:53:16 (139 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109817 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:16.499996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:16.500324) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020289 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:16.549812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:16.550164) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8cbd3940c47f0babdf44937b799e160278b4a1fc --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 8cbd3940c47f0babdf44937b799e160278b4a1fc --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 16:53:16,707 truncating revision to first 12 chars 2016-04-14 16:53:16,707 Setting DEBUG logging. 2016-04-14 16:53:16,707 attempt 1/10 2016-04-14 16:53:16,708 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8cbd3940c47f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 16:53:17,057 unpacking tar archive at: fx-team-8cbd3940c47f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628194 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:17.191223) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:17.191568) ========= script_repo_revision: 8cbd3940c47f0babdf44937b799e160278b4a1fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:17.191972) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:17.192265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 16:53:17.202386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-04-14 16:53:17.202658) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:53:17 INFO - MultiFileLogger online at 20160414 16:53:17 in /builds/slave/test 16:53:17 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 16:53:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:53:17 INFO - {'append_to_log': False, 16:53:17 INFO - 'base_work_dir': '/builds/slave/test', 16:53:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:53:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:53:17 INFO - 'branch': 'Fx-Team-Non-PGO', 16:53:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:17 INFO - 'config_files': ('talos/linux_config.py',), 16:53:17 INFO - 'default_actions': ('clobber', 16:53:17 INFO - 'read-buildbot-config', 16:53:17 INFO - 'download-and-extract', 16:53:17 INFO - 'populate-webroot', 16:53:17 INFO - 'create-virtualenv', 16:53:17 INFO - 'install', 16:53:17 INFO - 'run-tests'), 16:53:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:17 INFO - 'download_minidump_stackwalk': True, 16:53:17 INFO - 'download_symbols': 'ondemand', 16:53:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:17 INFO - 'installer_path': 'installer.exe', 16:53:17 INFO - 'log_level': 'info', 16:53:17 INFO - 'log_name': 'talos', 16:53:17 INFO - 'log_to_console': True, 16:53:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:53:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:53:17 INFO - 'opt_config_files': (), 16:53:17 INFO - 'pip_index': False, 16:53:17 INFO - 'sps_profile': False, 16:53:17 INFO - 'sps_profile_interval': 0, 16:53:17 INFO - 'suite': 'dromaeojs', 16:53:17 INFO - 'system_bits': '32', 16:53:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:17 INFO - 'title': 'talos-linux64-ix-066', 16:53:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:17 INFO - 'use_talos_json': True, 16:53:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:53:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:17 INFO - 'work_dir': 'build'} 16:53:17 INFO - ##### 16:53:17 INFO - ##### Running clobber step. 16:53:17 INFO - ##### 16:53:17 INFO - Running pre-action listener: _resource_record_pre_action 16:53:17 INFO - Running main action method: clobber 16:53:17 INFO - rmtree: /builds/slave/test/build 16:53:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:53:17 INFO - Running post-action listener: _resource_record_post_action 16:53:17 INFO - ##### 16:53:17 INFO - ##### Running read-buildbot-config step. 16:53:17 INFO - ##### 16:53:17 INFO - Running pre-action listener: _resource_record_pre_action 16:53:17 INFO - Running main action method: read_buildbot_config 16:53:17 INFO - Using buildbot properties: 16:53:17 INFO - { 16:53:17 INFO - "project": "", 16:53:17 INFO - "product": "firefox", 16:53:17 INFO - "script_repo_revision": "production", 16:53:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:53:17 INFO - "repository": "", 16:53:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:53:17 INFO - "buildid": "20160414161850", 16:53:17 INFO - "pgo_build": "False", 16:53:17 INFO - "basedir": "/builds/slave/test", 16:53:17 INFO - "buildnumber": 2835, 16:53:17 INFO - "slavename": "talos-linux64-ix-066", 16:53:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:53:17 INFO - "platform": "ubuntu64_hw", 16:53:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:53:17 INFO - "branch": "fx-team", 16:53:17 INFO - "repo_path": "integration/fx-team", 16:53:17 INFO - "revision": "8cbd3940c47f0babdf44937b799e160278b4a1fc", 16:53:17 INFO - "stage_platform": "linux64", 16:53:17 INFO - "builduid": "3e25626c57874c75bbb1991d4b470452", 16:53:17 INFO - "slavebuilddir": "test" 16:53:17 INFO - } 16:53:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:53:17 INFO - Running post-action listener: _resource_record_post_action 16:53:17 INFO - ##### 16:53:17 INFO - ##### Running download-and-extract step. 16:53:17 INFO - ##### 16:53:17 INFO - Running pre-action listener: _resource_record_pre_action 16:53:17 INFO - Running main action method: download_and_extract 16:53:17 INFO - mkdir: /builds/slave/test/build/tests 16:53:17 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')]} 16:53:17 INFO - https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:53:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:53:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:53:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:53:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:53:18 INFO - Downloaded 1361 bytes. 16:53:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:53:18 INFO - Using the following test package requirements: 16:53:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:53:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:53:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:53:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:18 INFO - u'jsshell-linux-x86_64.zip'], 16:53:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:53:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:53:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:53:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:53:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:53:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:53:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:53:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:18 INFO - https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:53:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:53:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:53:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:53:19 INFO - Downloaded 22202881 bytes. 16:53:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:53:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:53:20 INFO - Return code: 0 16:53:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:53: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')]} 16:53:20 INFO - https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:53:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:53:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:53:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:53:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:53:21 INFO - Downloaded 22202881 bytes. 16:53:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:53:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:53:23 INFO - Return code: 0 16:53:23 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')]} 16:53:23 INFO - https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:53:24 INFO - Downloaded 10841076 bytes. 16:53:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:53:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:53:24 INFO - Return code: 0 16:53:24 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')]} 16:53:24 INFO - https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:53:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:53:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:53:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:53:27 INFO - Downloaded 54448369 bytes. 16:53:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:53:27 INFO - mkdir: /builds/slave/test/properties 16:53:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:53:27 INFO - Writing to file /builds/slave/test/properties/build_url 16:53:27 INFO - Contents: 16:53:27 INFO - build_url:https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:53:28 INFO - Running post-action listener: _resource_record_post_action 16:53:28 INFO - Running post-action listener: set_extra_try_arguments 16:53:28 INFO - ##### 16:53:28 INFO - ##### Running populate-webroot step. 16:53:28 INFO - ##### 16:53:28 INFO - Running pre-action listener: _resource_record_pre_action 16:53:28 INFO - Running main action method: populate_webroot 16:53:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:53:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:53:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:53:28 INFO - '--tppagecycles', 16:53:28 INFO - '7'], 16:53:28 INFO - 'tests': ['tsvgm']}}, 16:53:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:53:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:53:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:53:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:53:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:53:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:53:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:28 INFO - 'talos_options': ['--disable-e10s'], 16:53:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:28 INFO - 'talos_options': ['--disable-e10s'], 16:53:28 INFO - 'tests': ['damp', 'tps']}, 16:53:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:28 INFO - 'tests': ['damp', 'tps']}, 16:53:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:53:28 INFO - 'tests': ['dromaeo_dom']}, 16:53:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:53:28 INFO - 'tests': ['a11yr', 16:53:28 INFO - 'ts_paint', 16:53:28 INFO - 'tpaint', 16:53:28 INFO - 'sessionrestore', 16:53:28 INFO - 'sessionrestore_no_auto_restore', 16:53:28 INFO - 'tabpaint']}, 16:53:28 INFO - 'other-e10s': {'tests': ['a11yr', 16:53:28 INFO - 'ts_paint', 16:53:28 INFO - 'tpaint', 16:53:28 INFO - 'sessionrestore', 16:53:28 INFO - 'sessionrestore_no_auto_restore', 16:53:28 INFO - 'tabpaint']}, 16:53:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:53:28 INFO - 'ts_paint', 16:53:28 INFO - 'tpaint', 16:53:28 INFO - 'sessionrestore', 16:53:28 INFO - 'sessionrestore_no_auto_restore', 16:53:28 INFO - 'tabpaint']}, 16:53:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:53:28 INFO - 'ts_paint', 16:53:28 INFO - 'tpaint', 16:53:28 INFO - 'sessionrestore', 16:53:28 INFO - 'sessionrestore_no_auto_restore', 16:53:28 INFO - 'tabpaint']}, 16:53:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:53:28 INFO - 'tests': ['a11yr', 16:53:28 INFO - 'ts_paint', 16:53:28 INFO - 'tpaint', 16:53:28 INFO - 'sessionrestore', 16:53:28 INFO - 'sessionrestore_no_auto_restore', 16:53:28 INFO - 'tabpaint']}, 16:53:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:53:28 INFO - 'tests': ['a11yr', 16:53:28 INFO - 'ts_paint', 16:53:28 INFO - 'tpaint', 16:53:28 INFO - 'sessionrestore', 16:53:28 INFO - 'sessionrestore_no_auto_restore', 16:53:28 INFO - 'tabpaint']}, 16:53:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:53:28 INFO - 'tests': ['tsvgx', 16:53:28 INFO - 'tsvgr_opacity', 16:53:28 INFO - 'tart', 16:53:28 INFO - 'tscrollx', 16:53:28 INFO - 'cart']}, 16:53:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:53:28 INFO - 'tsvgr_opacity', 16:53:28 INFO - 'tart', 16:53:28 INFO - 'tscrollx', 16:53:28 INFO - 'cart']}, 16:53:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:28 INFO - 'talos_options': ['--disable-e10s'], 16:53:28 INFO - 'tests': ['tp5o']}, 16:53:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:28 INFO - 'tests': ['tp5o']}, 16:53:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:28 INFO - 'talos_options': ['--disable-e10s', 16:53:28 INFO - '--xperf_path', 16:53:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:28 INFO - 'tests': ['tp5n']}, 16:53:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:28 INFO - 'talos_options': ['--xperf_path', 16:53:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:28 INFO - 'tests': ['tp5n']}}, 16:53:28 INFO - 'talos.zip': {'path': '', 16:53:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:53:28 INFO - Running post-action listener: _resource_record_post_action 16:53:28 INFO - ##### 16:53:28 INFO - ##### Running create-virtualenv step. 16:53:28 INFO - ##### 16:53:28 INFO - Running pre-action listener: _resource_record_pre_action 16:53:28 INFO - Running main action method: create_virtualenv 16:53:28 INFO - Creating virtualenv /builds/slave/test/build/venv 16:53:28 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 16:53:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:53:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:28 INFO - Using real prefix '/usr' 16:53:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:53:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:30 INFO - Installing pip.................done. 16:53:30 INFO - Return code: 0 16:53:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:53:30 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')]} 16:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:30 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')]} 16:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:30 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 0x7f99a3b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f410>, '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 0x1770310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', '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 16:53:30 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 16:53:30 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 16:53:30 INFO - Using env: {'DISPLAY': ':0', 16:53:30 INFO - 'HOME': '/home/cltbld', 16:53:30 INFO - 'LANG': 'en_US.UTF-8', 16:53:30 INFO - 'LANGUAGE': 'en_US:en', 16:53:30 INFO - 'LOGNAME': 'cltbld', 16:53:30 INFO - 'MAIL': '/var/mail/cltbld', 16:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:30 INFO - 'MOZ_NO_REMOTE': '1', 16:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:30 INFO - 'NO_EM_RESTART': '1', 16:53:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:30 INFO - 'PWD': '/builds/slave/test', 16:53:30 INFO - 'SHELL': '/bin/bash', 16:53:30 INFO - 'SHLVL': '1', 16:53:30 INFO - 'TERM': 'linux', 16:53:30 INFO - 'TMOUT': '86400', 16:53:30 INFO - 'USER': 'cltbld', 16:53:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', 16:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:30 INFO - '_': '/tools/buildbot/bin/python'} 16:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:31 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 16:53:31 INFO - Cleaning up... 16:53:31 INFO - Return code: 0 16:53:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99a3b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f410>, '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 0x1770310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', '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 16:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:53:31 INFO - Using env: {'DISPLAY': ':0', 16:53:31 INFO - 'HOME': '/home/cltbld', 16:53:31 INFO - 'LANG': 'en_US.UTF-8', 16:53:31 INFO - 'LANGUAGE': 'en_US:en', 16:53:31 INFO - 'LOGNAME': 'cltbld', 16:53:31 INFO - 'MAIL': '/var/mail/cltbld', 16:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:31 INFO - 'MOZ_NO_REMOTE': '1', 16:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:31 INFO - 'NO_EM_RESTART': '1', 16:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:31 INFO - 'PWD': '/builds/slave/test', 16:53:31 INFO - 'SHELL': '/bin/bash', 16:53:31 INFO - 'SHLVL': '1', 16:53:31 INFO - 'TERM': 'linux', 16:53:31 INFO - 'TMOUT': '86400', 16:53:31 INFO - 'USER': 'cltbld', 16:53:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', 16:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:31 INFO - '_': '/tools/buildbot/bin/python'} 16:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:31 INFO - Downloading/unpacking psutil>=0.7.1 16:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:53:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:33 INFO - Installing collected packages: psutil 16:53:33 INFO - Running setup.py install for psutil 16:53:33 INFO - building 'psutil._psutil_linux' extension 16:53:33 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 16:53:33 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 16:53:33 INFO - building 'psutil._psutil_posix' extension 16:53:33 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 16:53:33 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 16:53:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:33 INFO - Successfully installed psutil 16:53:33 INFO - Cleaning up... 16:53:33 INFO - Return code: 0 16:53:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:53:33 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')]} 16:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:33 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')]} 16:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:33 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 0x7f99a3b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f410>, '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 0x1770310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', '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 16:53:33 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 16:53:33 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 16:53:33 INFO - Using env: {'DISPLAY': ':0', 16:53:33 INFO - 'HOME': '/home/cltbld', 16:53:33 INFO - 'LANG': 'en_US.UTF-8', 16:53:33 INFO - 'LANGUAGE': 'en_US:en', 16:53:33 INFO - 'LOGNAME': 'cltbld', 16:53:33 INFO - 'MAIL': '/var/mail/cltbld', 16:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:33 INFO - 'MOZ_NO_REMOTE': '1', 16:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:33 INFO - 'NO_EM_RESTART': '1', 16:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:33 INFO - 'PWD': '/builds/slave/test', 16:53:33 INFO - 'SHELL': '/bin/bash', 16:53:33 INFO - 'SHLVL': '1', 16:53:33 INFO - 'TERM': 'linux', 16:53:33 INFO - 'TMOUT': '86400', 16:53:33 INFO - 'USER': 'cltbld', 16:53:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', 16:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:33 INFO - '_': '/tools/buildbot/bin/python'} 16:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:53:36 INFO - Installing collected packages: mozsystemmonitor 16:53:36 INFO - Running setup.py install for mozsystemmonitor 16:53:36 INFO - Successfully installed mozsystemmonitor 16:53:36 INFO - Cleaning up... 16:53:36 INFO - Return code: 0 16:53:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:36 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 0x7f99a3b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f410>, '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 0x1770310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', '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 16:53:36 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 16:53:36 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 16:53:36 INFO - Using env: {'DISPLAY': ':0', 16:53:36 INFO - 'HOME': '/home/cltbld', 16:53:36 INFO - 'LANG': 'en_US.UTF-8', 16:53:36 INFO - 'LANGUAGE': 'en_US:en', 16:53:36 INFO - 'LOGNAME': 'cltbld', 16:53:36 INFO - 'MAIL': '/var/mail/cltbld', 16:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:36 INFO - 'MOZ_NO_REMOTE': '1', 16:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:36 INFO - 'NO_EM_RESTART': '1', 16:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:36 INFO - 'PWD': '/builds/slave/test', 16:53:36 INFO - 'SHELL': '/bin/bash', 16:53:36 INFO - 'SHLVL': '1', 16:53:36 INFO - 'TERM': 'linux', 16:53:36 INFO - 'TMOUT': '86400', 16:53:36 INFO - 'USER': 'cltbld', 16:53:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', 16:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:36 INFO - '_': '/tools/buildbot/bin/python'} 16:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:36 INFO - Downloading/unpacking blobuploader==1.2.4 16:53:36 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 16:53:36 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 16:53:36 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 16:53:36 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 16:53:36 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 16:53:36 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 16:53:38 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:38 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 16:53:38 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 16:53:38 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 16:53:38 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 16:53:38 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 16:53:38 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 16:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:38 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 16:53:38 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 16:53:38 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 16:53:38 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 16:53:38 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 16:53:38 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 16:53:39 INFO - Downloading docopt-0.6.1.tar.gz 16:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:39 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:39 INFO - Running setup.py install for blobuploader 16:53:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:39 INFO - Running setup.py install for requests 16:53:39 INFO - Running setup.py install for docopt 16:53:39 INFO - Successfully installed blobuploader requests docopt 16:53:39 INFO - Cleaning up... 16:53:39 INFO - Return code: 0 16:53:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:39 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 0x7f99a3b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f410>, '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 0x1770310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', '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 16:53:39 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 16:53:39 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 16:53:39 INFO - Using env: {'DISPLAY': ':0', 16:53:39 INFO - 'HOME': '/home/cltbld', 16:53:39 INFO - 'LANG': 'en_US.UTF-8', 16:53:39 INFO - 'LANGUAGE': 'en_US:en', 16:53:39 INFO - 'LOGNAME': 'cltbld', 16:53:39 INFO - 'MAIL': '/var/mail/cltbld', 16:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:39 INFO - 'MOZ_NO_REMOTE': '1', 16:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:39 INFO - 'NO_EM_RESTART': '1', 16:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:39 INFO - 'PWD': '/builds/slave/test', 16:53:39 INFO - 'SHELL': '/bin/bash', 16:53:39 INFO - 'SHLVL': '1', 16:53:39 INFO - 'TERM': 'linux', 16:53:39 INFO - 'TMOUT': '86400', 16:53:39 INFO - 'USER': 'cltbld', 16:53:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', 16:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:39 INFO - '_': '/tools/buildbot/bin/python'} 16:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:40 INFO - Running setup.py (path:/tmp/pip-Pes49Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:40 INFO - Running setup.py (path:/tmp/pip-lw1qaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:40 INFO - Running setup.py (path:/tmp/pip-tcku0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:40 INFO - Running setup.py (path:/tmp/pip-HoGfxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:40 INFO - Running setup.py (path:/tmp/pip-GofyXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:40 INFO - Running setup.py (path:/tmp/pip-LDwywU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:40 INFO - Running setup.py (path:/tmp/pip-7NJKPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:40 INFO - Running setup.py (path:/tmp/pip-O6Iat9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:40 INFO - Running setup.py (path:/tmp/pip-MD6ZoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:40 INFO - Running setup.py (path:/tmp/pip-qRfTGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:40 INFO - Running setup.py (path:/tmp/pip-LHx5RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:40 INFO - Running setup.py (path:/tmp/pip-fRwUs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:41 INFO - Running setup.py (path:/tmp/pip-FEaqVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:41 INFO - Running setup.py (path:/tmp/pip-h4pKwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:41 INFO - Running setup.py (path:/tmp/pip-zR0Wzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:41 INFO - Running setup.py (path:/tmp/pip-3vZ0yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:41 INFO - Running setup.py (path:/tmp/pip-0ZgZvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:41 INFO - Running setup.py install for manifestparser 16:53:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:41 INFO - Running setup.py install for mozcrash 16:53:41 INFO - Running setup.py install for mozdebug 16:53:41 INFO - Running setup.py install for mozdevice 16:53:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:53:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:41 INFO - Running setup.py install for mozfile 16:53:41 INFO - Running setup.py install for mozhttpd 16:53:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Running setup.py install for mozinfo 16:53:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Running setup.py install for mozInstall 16:53:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Running setup.py install for mozleak 16:53:42 INFO - Running setup.py install for mozlog 16:53:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Running setup.py install for moznetwork 16:53:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Running setup.py install for mozprocess 16:53:42 INFO - Running setup.py install for mozprofile 16:53:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Running setup.py install for mozrunner 16:53:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:42 INFO - Running setup.py install for mozscreenshot 16:53:42 INFO - Running setup.py install for moztest 16:53:43 INFO - Running setup.py install for mozversion 16:53:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:43 INFO - Cleaning up... 16:53:43 INFO - Return code: 0 16:53:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:43 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')]} 16:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:43 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')]} 16:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:43 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 0x7f99a3b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f410>, '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 0x1770310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', '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 16:53:43 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 16:53:43 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 16:53:43 INFO - Using env: {'DISPLAY': ':0', 16:53:43 INFO - 'HOME': '/home/cltbld', 16:53:43 INFO - 'LANG': 'en_US.UTF-8', 16:53:43 INFO - 'LANGUAGE': 'en_US:en', 16:53:43 INFO - 'LOGNAME': 'cltbld', 16:53:43 INFO - 'MAIL': '/var/mail/cltbld', 16:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:43 INFO - 'MOZ_NO_REMOTE': '1', 16:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:43 INFO - 'NO_EM_RESTART': '1', 16:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:43 INFO - 'PWD': '/builds/slave/test', 16:53:43 INFO - 'SHELL': '/bin/bash', 16:53:43 INFO - 'SHLVL': '1', 16:53:43 INFO - 'TERM': 'linux', 16:53:43 INFO - 'TMOUT': '86400', 16:53:43 INFO - 'USER': 'cltbld', 16:53:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', 16:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:43 INFO - '_': '/tools/buildbot/bin/python'} 16:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:43 INFO - Running setup.py (path:/tmp/pip-Ub17xW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:43 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)) 16:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:43 INFO - Running setup.py (path:/tmp/pip-jgkvYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:43 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)) 16:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:43 INFO - Running setup.py (path:/tmp/pip-jxRFyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:43 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)) 16:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:43 INFO - Running setup.py (path:/tmp/pip-zinxtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:43 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)) 16:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:43 INFO - Running setup.py (path:/tmp/pip-gl5Zps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:43 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)) 16:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:43 INFO - Running setup.py (path:/tmp/pip-FN1Vxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:43 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)) 16:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:43 INFO - Running setup.py (path:/tmp/pip-httx5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:43 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)) 16:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:43 INFO - Running setup.py (path:/tmp/pip-k6FkBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:43 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)) 16:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:43 INFO - Running setup.py (path:/tmp/pip-QuHuXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:44 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)) 16:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:44 INFO - Running setup.py (path:/tmp/pip-afmjn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:44 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)) 16:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:44 INFO - Running setup.py (path:/tmp/pip-xhuajn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:44 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)) 16:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:44 INFO - Running setup.py (path:/tmp/pip-VsHkuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:44 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)) 16:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:44 INFO - Running setup.py (path:/tmp/pip-YhaQX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:44 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)) 16:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:44 INFO - Running setup.py (path:/tmp/pip-4AVt_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:44 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)) 16:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:44 INFO - Running setup.py (path:/tmp/pip-ub4aXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:44 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)) 16:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:44 INFO - Running setup.py (path:/tmp/pip-QWG40I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:44 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)) 16:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:44 INFO - Running setup.py (path:/tmp/pip-lig2lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:44 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)) 16:53:44 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)) 16:53:44 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)) 16:53:44 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)) 16:53:44 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)) 16:53:44 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)) 16:53:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:44 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 16:53:44 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 16:53:44 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 16:53:44 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 16:53:44 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 16:53:44 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 16:53:46 INFO - Downloading blessings-1.6.tar.gz 16:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:46 INFO - Installing collected packages: blessings 16:53:46 INFO - Running setup.py install for blessings 16:53:46 INFO - Successfully installed blessings 16:53:46 INFO - Cleaning up... 16:53:46 INFO - Return code: 0 16:53:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:46 INFO - Reading from file tmpfile_stdout 16:53:46 INFO - Current package versions: 16:53:46 INFO - argparse == 1.2.1 16:53:46 INFO - blessings == 1.6 16:53:46 INFO - blobuploader == 1.2.4 16:53:46 INFO - docopt == 0.6.1 16:53:46 INFO - manifestparser == 1.1 16:53:46 INFO - mozInstall == 1.12 16:53:46 INFO - mozcrash == 0.17 16:53:46 INFO - mozdebug == 0.1 16:53:46 INFO - mozdevice == 0.48 16:53:46 INFO - mozfile == 1.2 16:53:46 INFO - mozhttpd == 0.7 16:53:46 INFO - mozinfo == 0.9 16:53:46 INFO - mozleak == 0.1 16:53:46 INFO - mozlog == 3.1 16:53:46 INFO - moznetwork == 0.27 16:53:46 INFO - mozprocess == 0.22 16:53:46 INFO - mozprofile == 0.28 16:53:46 INFO - mozrunner == 6.11 16:53:46 INFO - mozscreenshot == 0.1 16:53:46 INFO - mozsystemmonitor == 0.0 16:53:46 INFO - moztest == 0.7 16:53:46 INFO - mozversion == 1.4 16:53:46 INFO - psutil == 3.1.1 16:53:46 INFO - requests == 1.2.3 16:53:46 INFO - wsgiref == 0.1.2 16:53:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:46 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 0x7f99a3b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f410>, '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 0x1770310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', '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 16:53:46 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 16:53:46 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 16:53:46 INFO - Using env: {'DISPLAY': ':0', 16:53:46 INFO - 'HOME': '/home/cltbld', 16:53:46 INFO - 'LANG': 'en_US.UTF-8', 16:53:46 INFO - 'LANGUAGE': 'en_US:en', 16:53:46 INFO - 'LOGNAME': 'cltbld', 16:53:46 INFO - 'MAIL': '/var/mail/cltbld', 16:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:46 INFO - 'MOZ_NO_REMOTE': '1', 16:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:46 INFO - 'NO_EM_RESTART': '1', 16:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:46 INFO - 'PWD': '/builds/slave/test', 16:53:46 INFO - 'SHELL': '/bin/bash', 16:53:46 INFO - 'SHLVL': '1', 16:53:46 INFO - 'TERM': 'linux', 16:53:46 INFO - 'TMOUT': '86400', 16:53:46 INFO - 'USER': 'cltbld', 16:53:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', 16:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:46 INFO - '_': '/tools/buildbot/bin/python'} 16:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:47 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)) 16:53:47 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)) 16:53:47 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)) 16:53:47 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)) 16:53:47 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)) 16:53:47 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)) 16:53:47 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)) 16:53:47 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)) 16:53:47 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)) 16:53:47 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)) 16:53:47 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)) 16:53:47 INFO - Cleaning up... 16:53:47 INFO - Return code: 0 16:53:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53:47 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')]} 16:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:47 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')]} 16:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:47 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 0x7f99a3b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f410>, '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 0x1770310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', '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 16:53:47 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 16:53:47 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 16:53:47 INFO - Using env: {'DISPLAY': ':0', 16:53:47 INFO - 'HOME': '/home/cltbld', 16:53:47 INFO - 'LANG': 'en_US.UTF-8', 16:53:47 INFO - 'LANGUAGE': 'en_US:en', 16:53:47 INFO - 'LOGNAME': 'cltbld', 16:53:47 INFO - 'MAIL': '/var/mail/cltbld', 16:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:47 INFO - 'MOZ_NO_REMOTE': '1', 16:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:47 INFO - 'NO_EM_RESTART': '1', 16:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:47 INFO - 'PWD': '/builds/slave/test', 16:53:47 INFO - 'SHELL': '/bin/bash', 16:53:47 INFO - 'SHLVL': '1', 16:53:47 INFO - 'TERM': 'linux', 16:53:47 INFO - 'TMOUT': '86400', 16:53:47 INFO - 'USER': 'cltbld', 16:53:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', 16:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:47 INFO - '_': '/tools/buildbot/bin/python'} 16:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:47 INFO - Downloading/unpacking jsonschema 16:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:49 INFO - Downloading/unpacking functools32 (from jsonschema) 16:53:49 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 16:53:49 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 16:53:49 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 16:53:49 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 16:53:49 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 16:53:49 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 16:53:49 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:49 INFO - warning: no files found matching '*.txt' 16:53:49 INFO - no previously-included directories found matching 'build' 16:53:49 INFO - no previously-included directories found matching 'dist' 16:53:49 INFO - no previously-included directories found matching '.git*' 16:53:49 INFO - Installing collected packages: jsonschema, functools32 16:53:49 INFO - Running setup.py install for functools32 16:53:49 INFO - warning: no files found matching '*.txt' 16:53:49 INFO - no previously-included directories found matching 'build' 16:53:49 INFO - no previously-included directories found matching 'dist' 16:53:49 INFO - no previously-included directories found matching '.git*' 16:53:49 INFO - Successfully installed jsonschema functools32 16:53:49 INFO - Cleaning up... 16:53:49 INFO - Return code: 0 16:53:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:49 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 0x7f99a3b2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f410>, '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 0x1770310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', '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 16:53:49 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 16:53:49 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 16:53:49 INFO - Using env: {'DISPLAY': ':0', 16:53:49 INFO - 'HOME': '/home/cltbld', 16:53:49 INFO - 'LANG': 'en_US.UTF-8', 16:53:49 INFO - 'LANGUAGE': 'en_US:en', 16:53:49 INFO - 'LOGNAME': 'cltbld', 16:53:49 INFO - 'MAIL': '/var/mail/cltbld', 16:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:49 INFO - 'MOZ_NO_REMOTE': '1', 16:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:49 INFO - 'NO_EM_RESTART': '1', 16:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:49 INFO - 'PWD': '/builds/slave/test', 16:53:49 INFO - 'SHELL': '/bin/bash', 16:53:49 INFO - 'SHLVL': '1', 16:53:49 INFO - 'TERM': 'linux', 16:53:49 INFO - 'TMOUT': '86400', 16:53:49 INFO - 'USER': 'cltbld', 16:53:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', 16:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:49 INFO - '_': '/tools/buildbot/bin/python'} 16:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:49 INFO - Downloading/unpacking flake8 16:53:49 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 16:53:49 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 16:53:49 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 16:53:49 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 16:53:49 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 16:53:49 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 16:53:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:53:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:53:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:53:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:52 INFO - no previously-included directories found matching 'docs/_build' 16:53:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:53:52 INFO - Running setup.py install for pep8 16:53:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:52 INFO - no previously-included directories found matching 'docs/_build' 16:53:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:53:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:53:52 INFO - Cleaning up... 16:53:52 INFO - Return code: 0 16:53:52 INFO - Running post-action listener: _resource_record_post_action 16:53:52 INFO - Running post-action listener: _start_resource_monitoring 16:53:52 INFO - Starting resource monitoring. 16:53:52 INFO - ##### 16:53:52 INFO - ##### Running install step. 16:53:52 INFO - ##### 16:53:52 INFO - Running pre-action listener: _resource_record_pre_action 16:53:52 INFO - Running main action method: install 16:53:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:52 INFO - Reading from file tmpfile_stdout 16:53:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:53 INFO - Reading from file tmpfile_stdout 16:53:53 INFO - Output received: 16:53:53 INFO - Usage: mozinstall [options] installer 16:53:53 INFO - Options: 16:53:53 INFO - -h, --help show this help message and exit 16:53:53 INFO - -d DEST, --destination=DEST 16:53:53 INFO - Directory to install application into. [default: 16:53:53 INFO - "/builds/slave/test"] 16:53:53 INFO - --app=APP Application being installed. [default: firefox] 16:53:53 INFO - mkdir: /builds/slave/test/build/application 16:53:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:54:08 INFO - Reading from file tmpfile_stdout 16:54:08 INFO - Output received: 16:54:08 INFO - /builds/slave/test/build/application/firefox/firefox 16:54:08 INFO - Running post-action listener: _resource_record_post_action 16:54:08 INFO - ##### 16:54:08 INFO - ##### Running run-tests step. 16:54:08 INFO - ##### 16:54:08 INFO - Running pre-action listener: _resource_record_pre_action 16:54:08 INFO - Running main action method: run_tests 16:54:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:54:08 INFO - Python 2.7.3 16:54:08 INFO - Return code: 0 16:54:08 INFO - grabbing minidump binary from tooltool 16:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:08 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 0x176f410>, '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 0x1770310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17707a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:54:08 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 16:54:08 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 16:54:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:54:08 INFO - Return code: 0 16:54:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:54:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:54:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:54:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:54:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:54:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:54:09 INFO - Return code: 0 16:54:09 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/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:54:09 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/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:54:09 INFO - Using env: {'DISPLAY': ':0', 16:54:09 INFO - 'HOME': '/home/cltbld', 16:54:09 INFO - 'LANG': 'en_US.UTF-8', 16:54:09 INFO - 'LANGUAGE': 'en_US:en', 16:54:09 INFO - 'LOGNAME': 'cltbld', 16:54:09 INFO - 'MAIL': '/var/mail/cltbld', 16:54:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:54:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:09 INFO - 'MOZ_NO_REMOTE': '1', 16:54:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:09 INFO - 'NO_EM_RESTART': '1', 16:54:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:09 INFO - 'PWD': '/builds/slave/test', 16:54:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:54:09 INFO - 'SHELL': '/bin/bash', 16:54:09 INFO - 'SHLVL': '1', 16:54:09 INFO - 'TERM': 'linux', 16:54:09 INFO - 'TMOUT': '86400', 16:54:09 INFO - 'USER': 'cltbld', 16:54:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381', 16:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:09 INFO - '_': '/tools/buildbot/bin/python'} 16:54:09 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/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:54:09 INFO - mozversion application_buildid: 20160414161850 16:54:09 INFO - mozversion application_changeset: 8cbd3940c47f0babdf44937b799e160278b4a1fc 16:54:09 INFO - mozversion application_display_name: Nightly 16:54:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:54:09 INFO - mozversion application_name: Firefox 16:54:09 INFO - mozversion application_remotingname: firefox 16:54:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:54:09 INFO - mozversion application_vendor: Mozilla 16:54:09 INFO - mozversion application_version: 48.0a1 16:54:09 INFO - mozversion platform_buildid: 20160414161850 16:54:09 INFO - mozversion platform_changeset: 8cbd3940c47f0babdf44937b799e160278b4a1fc 16:54:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:54:09 INFO - mozversion platform_version: 48.0a1 16:54:09 INFO - using testdate: 1460678049 16:54:09 INFO - actual date: 1460678049 16:54:09 INFO - starting webserver on 'localhost:41316' 16:54:09 INFO - SUITE-START | Running 2 tests 16:54:09 INFO - TEST-START | dromaeo_css 16:54:09 INFO - operating with platform_type : linux_ 16:54:09 INFO - Initialising browser for dromaeo_css test... 16:54:10 INFO - TEST-INFO | started process 4258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4I5fBL/profile http://localhost:41316/getInfo.html) 16:54:14 INFO - PROCESS | 4258 | __metrics Screen width/height:1600/1200 16:54:14 INFO - PROCESS | 4258 | colorDepth:24 16:54:14 INFO - PROCESS | 4258 | Browser inner width/height: 1024/697 16:54:14 INFO - PROCESS | 4258 | __metrics 16:54:15 ERROR - PROCESS | 4258 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:54:16 INFO - TEST-INFO | 4258: exit 0 16:54:16 INFO - Browser initialized. 16:54:16 INFO - Running cycle 1/1 for dromaeo_css test... 16:54:16 INFO - TEST-INFO | started process 4337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4I5fBL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:54:28 INFO - PROCESS | 4337 | RSS: Main: 155115520 16:54:28 INFO - PROCESS | 4337 | 16:55:19 INFO - PROCESS | 4337 | 1460678119148 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] 16:57:31 INFO - PROCESS | 4337 | Cycle 1(1): loaded http://localhost:41316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41316/tests/dromaeo/cssquery-ext.html) 16:57:33 INFO - PROCESS | 4337 | RSS: Main: 269512704 16:57:33 INFO - PROCESS | 4337 | 17:00:35 INFO - PROCESS | 4337 | Cycle 1(1): loaded http://localhost:41316/tests/dromaeo/cssquery-ext.html (next: http://localhost:41316/tests/dromaeo/cssquery-jquery.html) 17:00:36 INFO - PROCESS | 4337 | RSS: Main: 241455104 17:00:36 INFO - PROCESS | 4337 | 17:03:38 INFO - PROCESS | 4337 | Cycle 1(1): loaded http://localhost:41316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41316/tests/dromaeo/cssquery-mootools.html) 17:03:38 INFO - PROCESS | 4337 | RSS: Main: 238637056 17:03:38 INFO - PROCESS | 4337 | 17:06:40 INFO - PROCESS | 4337 | Cycle 1(1): loaded http://localhost:41316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41316/tests/dromaeo/cssquery-prototype.html) 17:06:41 INFO - PROCESS | 4337 | RSS: Main: 231981056 17:06:41 INFO - PROCESS | 4337 | 17:09:44 INFO - PROCESS | 4337 | Cycle 1(1): loaded http://localhost:41316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41316/tests/dromaeo/cssquery-yui.html) 17:09:45 INFO - PROCESS | 4337 | RSS: Main: 218537984 17:09:45 INFO - PROCESS | 4337 | 17:12:47 INFO - PROCESS | 4337 | Cycle 1(1): loaded http://localhost:41316/tests/dromaeo/cssquery-yui.html (next: http://localhost:41316/tests/dromaeo/cssquery-dojo.html) 17:12:47 INFO - PROCESS | 4337 | RSS: Main: 268365824 17:12:47 INFO - PROCESS | 4337 | 17:12:47 INFO - PROCESS | 4337 | __start_tp_report 17:12:47 INFO - PROCESS | 4337 | _x_x_mozilla_page_load 17:12:47 INFO - PROCESS | 4337 | _x_x_mozilla_page_load_details 17:12:47 INFO - PROCESS | 4337 | |i|pagename|runs| 17:12:47 INFO - PROCESS | 4337 | |0;dojo.html;2590.5984572391276;2695.110613497545;2704.7160048194937;2710.2411324829054;2737.0146747171016;4645;4675.672702910798;4711.363965864607;4720.291956206566;4735.621150307976;4704.106219818232;4714.481407045222;4722.763861806913;4750.073735621547;4764.857054288377;4244.83020679174;4285.742855428676;4314.0509088000745;4343.869683909472;4453.020335526196;4387.276099443588;4397.780110994453;4408.272635015219;4454.821807127727;4463.3081872309685;4180.226658068267;4268.722533035374;4323.481182258118;4353.673474489426;4382.4302840630835;4233.491980962273;4312.676549258818;4324.978375108104;4362.258416069276;4365.978170109129;4234.936475952833;4252.447181866369;4254.085371645111;4264.275073237526;4294.656427485794;4540.704854184501;4566.497685254652;4588.334691469751;4607.262837945913;4690.9530904690855;5021.84934451967;5035.320231768701;5039.949600503985;5039.949600503985;5066.189409694468;5070.569001634865;5075.5939524838295;5077.314562534085;5086.415062267813;5123.359580052494;4588.036512332381;4674.345591617176;4702.717836929761;4726.291056341576;4770.069836381872;5140.511651393112;5148.562372198405;5149.2276158576515;5164.1995490699;5167.4832516748775;4945.975270123627;4947.5794557462295;4948.628852836052;4949.133901567211;5000.474950130184;4888.926666100011;4974.353334066548;5074.162763144113;5089.592832573459;5092.28707980883;4950.2079667253065;4977.377827771528;4979.775910084055;4985.850424487271;5034.345535080416;4962.652614316963;4966.652334336634;4970.2793095001025;4971;5020.2720605511995;4178.247915375262;4197.748135111903;4260.2970509866145;4272.316429371285;4275.8075886585175;3714.925701485955;3719.75821571597;3725.0501122214205;3764.1906989997283;3766.039659886766;4391.8462853799965;4393.143337049245;4395.099004704028;4435.467743870756;4439.755813430293;4969.18008528596;5026.748662566857;5050.747462626854;5096.337476128154;5124;4388.0785035142335;4401.801918913657;4403.053343531092;4405.845795397146;4434.512203657595;4560.566746159176;4567.972206253633;4569.428821397325;4570.9314360284625;4618.1918164321105;4593.954060459419;4736.052789442194;4789.544993225638;4824;4831.227003679394;5071.87320316995;5086.9745651271505;5091.490850914879;5095;5144.228365745168;4638.1187574360765;4771.618270538418;4771.832985845479;4776.95223047779;4779.044191161712;4947.233178857283;4955.083309587738;4972.676776009548;5016.498350164954;5024.271480635361;5014.398272207359;5021.899562008813;5026.472220416804;5034.421041580119;5080.542751152266;4751.928721069117;4868.123737727243;4870.391201099863;4873;4922.581580565548;4872.4883887192755;4900.95099049005;4905.852824415273;4913.140200464976;4934.55588996992;4818.156822556109;4820.1805693031565;4830.468648448738;4831.685940413862;4880.267959806058;4737.170995075917;4868.9756551217015;4962.503749625153;4975.328330675313;4975.776090075883;4743.620510359094;4780.067886762048;4805.423349198119;4832.879178020437;4833.709977401367 17:12:47 INFO - PROCESS | 4337 | |1;ext.html;561.0015062100299;579.1920271221645;600.6786369292427;604.7218279591385;613.3130893399393;26292.73707262927;32997.67002329976;33508.49737253943;33861.32277354451;33926.8303658482;36708.449373259355;37279.440808387895;37362;37530.43704344437;37542.249155016885;7277.090363704537;7580.279873412017;7763.378929685611;7772.183920688331;9304.162625363715;9605.519724013771;9802.656907008257;9805.36265142767;9810.754731131707;9820;9753.122219000288;9755.365901216433;9836.409815411098;9853.556589953434;9860.802783944317;9604.279679024066;9777.266704997082;9780.266480014028;9785.315027948047;9790.265730070238;9634.614615415376;10041.49792510379;10049.748756281078;10053.246006549538;10060.993900609954;37246;37615.62384376149;37619.62380376216;37644.05889852748;38007.61992380068;3105.596272484585;3271.5419841222247;3562.964370356315;3614;3615.8192090395637;28455.57316640252;29231.853840730873;29491.852540737375;29687.406251875058;30048.399032019457;3431.77052462755;3436.1581412554083;3514.648535146465;3602.1534939289245;3615;168922;170979;171624;171656.14171929186;172282.13858930624;54552.181717274274;55652.72173639106;55713;55863.720681396335;55885;58741;58869;59022.40977590255;59041.70479147663;59119.40880591225;15070.438025535685;15465.845341546441;15504.534863954099;15509.379624814881;15514.456994005155;11861.5848445304;11938.403079845973;11951.282923024646;11953.940230298793;11963.760724785456;18863.245470181315;19189.232430702894;19218;19241.849283770025;19318.32385866488;7309;7322.3775979042375;7511.9624401877645;7565.243475652501;7620.1998790127345;974.2157563161722;1004.3271008424373;1012.1700205831148;1052.8210204265292;1057.7567159553191;27765.722342776717;27933.16200513988;28219.858900705363;28291.71708282891;28401.857990709916;984.5274268351232;1008.4655132779639;1010.2019404670228;1023.7287118913493;1029.5367084811865;14504.927475362767;14968.17675027862;15005.249737513299;15297.6175595611;15333.769993450107;353482;353569;359798;360551;360832;48646;49214.293213872865;49274.7681307963;49466.50533494691;49553;1117.2514415341577;1207.6256360528264;1222.7065504279087;1243.4280231093617;1261.369315342329;24568.140115095885;27101.86449067742;27269.181924542296;27762.444751105268;27818.304542386602;38175.427368588935;38538.614613853504;38565.22869542649;38592.2281554373;38671.41992870165;215998;221830;222051;222429;222457;32139;37400.25199496049;38172.809135955256;38187.42718859275;39286.607133929436;36053.81973090118;36382.63617363898;36445.27109457743;36460.81769591135;37041.62958370382;31179.37641247117;31519.52720709237;31935.520967185046;32168.517472238404;32481.350372991936;32127.839360803046;33426;33555.496667549516;33814.323713526086;34087.31825363528;33164.83417582897;33702.49446258259;34043.31913361768;34077.65922340844;34102.82948585241;29998.400031999674;30401.69598303989;30594.08217753471;30659;30664.233394165323;23491.41271468227;23950.56296622208;24101.758982409952;24151.758482414953;24274.51450971006 17:12:47 INFO - PROCESS | 4337 | |2;jquery.html;382.6747264824899;382.93107240696673;390.0910877655064;391.6240409207161;404.9392591111331;15874;17140.485785426426;17276.82723172768;17370.305187792488;17383.47849564512;16040.919795401036;16243.269052892618;16593.170341482906;16904.323827046905;16910.83089169108;4937.358143441356;5115.846524604268;5137.3064636274;5156.613254005964;5158.716270605115;3614.475900994354;5622.859428514299;5911.290645122592;5972.492338151263;5986.730597123118;5838.737256823453;5896.764129434839;5908.645481271137;5911.73397197125;5940.168376427304;5674.858128546799;5809.8547536311935;5830.82507524775;5846.123081537782;5849.093390524476;3329.93340133196;3538.681518663307;4934.333864928225;5256.132738098209;5256.843494431219;18266.452006439697;18830.623387532174;18833.81166188334;19216.903915480332;19271.13279902408;1953.990230048855;1994.0926878270352;2229.7881701238357;2257.7967982881455;2260.8191344692386;12576.371181440983;12969.092163548556;13115.213087214797;13467.12463689857;13520.323983800869;1755.5962128710469;1773.725072613747;1788.9284428622839;1853.7497437845852;1854.46220596027;65512.67243663751;67597;67859;68633.65683171603;68966;9583.233341332676;9657.565409556586;10206.387616743019;10212.336198147097;10684.839727404094;13985.58043258704;13985.72028559423;14075.085119467201;14079.507217247346;14090.225037622824;7255.673494692752;7276.126864776261;7357.852842943218;7387.2612738726775;7468.551886886804;6756.695948682321;6797.0823938767635;6848.3494068063455;6875.690593923286;6891.552049116792;6093;6131.417515336036;6133.417325354084;6299.874002520016;6426.260979987268;1679.4541773923524;1744.4069016534438;1815.1015247452594;1844.4097888675763;1853.6478069166815;887.0818702642863;909.3543584055262;942.9764255893657;976.7069879036261;1033.8914413986574;16390.26243819031;16399.590010249838;16780.328786848633;17294.481165565052;17306.826931730775;902.9729108126767;942.5946842857637;944.3908678902206;964.6816550538306;1003.242551873331;9522.381045232038;9632.90367096334;9759.12167904892;9891.752706182258;9934.819488675246;378652;381911;396287;396549;397914;68820.6558967212;70162.64918675374;71135.28864711287;71509;71621.28378716251;974.3958745577787;976.4580657735025;1004.4324956399611;1025.687165414541;1026.4764969865273;15012.624684382978;15072.321745521258;15112.546623601309;15281.541553753405;15537.22313884324;31805.20486987844;31808.36383272368;31913;32192.517112242866;32454;42393;43339.34990975201;43550;43582.34626480542;44169;7270.563766173835;7371.483996120434;7386.15059268191;7438.293362130589;7482.887756683763;10802.351858888493;10842.132629389473;11332.886671133183;11464.484098215768;11641.06871450265;9960.601575936882;10005.399676019462;10014.64948726791;10126.341787783771;10279.691609251735;9229.307801915018;9657.130858222794;9842.950785246314;9883.01169883006;10259.7435064124;8568.543347630794;9973.950130249303;10122.746931326776;10179.440130792582;10206;7154.320339567733;7169.7849064528145;7188.8921666174;7343.816404589928;7514.098308203051;9948.850767238353;9958.900410995797;9981.051800078982;10090.848637270594;10256.794864102527 17:12:47 INFO - PROCESS | 4337 | |3;mootools.html;1308.3654427602605;1445.797588337633;1488.813898262717;1611.6293252551914;1780.777402824647;7458.888116678248;7771.184025677308;7776;7776.222377762221;7781.572013539253;7752.651130699118;7904.683812647501;7904.841903161933;7913.089994650617;7915.8416831663335;2224.4661281292533;2251.2458326460655;2253.324002799162;2256.7630398808137;2256.8871556422196;2202.944926376845;2218.911243550256;2240.09276243121;2245.663150527426;2246.4945387287894;2197.6483762597986;2199.6260635691892;2207.39296693409;2207.602631526325;2236.1726161320335;2148.033384976751;2160.4274867160216;2167.674848772681;2171.8588291761066;2174.826013918883;2141.271967531047;2145.066895900273;2147.9463013424634;2148.1192710988576;2152.7847215278503;7710.845783084363;7760.107587627383;7812.765617031499;7814.0623125224765;8004.3996700247135;4574.817007319703;4716.292556116576;4735.100330937111;4750.976245118787;4766.594839438617;3034.2111051126644;3039.696030396965;3102.472579661463;3106.3942531206426;3115.890943816978;973.5764942250144;987.3779518903045;1001.8998100189996;1021.3157184686204;1024.1806554756165;10580.206484513692;10708.51811668469;10712.946435267851;10722.303050301627;10739.570417183304;4127.080907378084;4219.409282700424;4243.851465198703;4246.681498887596;4253.128108737701;8502.532360720219;8549.871751923725;8552.102029286836;8553.615087321086;8561.48631082137;4523.660725445605;4529.547045295444;4533;4547.181507328646;4555.2256116460285;3701.3337599232395;3751.381022131318;4200.7479551227025;4226.647472808671;4227.133437645275;3401.4387626041425;3448.793072415663;3505;3509.052555809968;3587.695045921074;1049.569676432659;1069.1660504806264;1070.0583486531802;1073.4954571351452;1087.516055355375;859.8581234096429;880.300161371711;882.3073886998675;886.3972498700946;904.3579058868146;5557.360903496069;5571.247881535941;5639.125935480007;5714.028615135437;5845.620034697731;898.3266561350174;904.3669431398048;934.7663084228943;947.0576776107816;955.9808803823885;3465.4108801503803;3738.4579236010627;3765.3975363941636;3771.773693578394;3774.0753515388906;9421.76445588852;9719.56261968213;9744.90255097454;9895.554700038372;9969.252306077073;9755.756106097262;9834.311598188058;9874.40753554789;9946.35348702332;9948.602055917827;7360.926390736131;7394.852102957911;7526.849463010819;7616.04799400075;7639.503432276884;5370.704611246419;5374.360819949797;5451.48210919962;5525.530329922001;5750.252467179407;8925.553722313989;9088.500132492512;9122.452652840851;9149.268058555434;9199.310051746012;8632.136786321318;8832.337574682053;8926;8931.151540603632;8936.642534298555;6110.480609148272;6601.933980660324;6648.667566621746;6805.0472933788315;6813.3527314905;7291.671874765542;7373;7404;7426.257374262531;7435.182129965591;6465.191851018622;6495.253045899593;6499.1876015498065;6505.0567667688865;6849.1096157499205;6374.90437643445;6378.872422551616;6499.2200935887995;6549.574277671936;6664.366885145903;6339.492840572835;6342.207224096988;6356.2054743157105;6360;6380.170577824853;4572.45130584332;4687.835925742583;4720.291956206459;4781.42622885256;4785.641076919175;4625.862461517129;4749.26386410107;4815.542523460265;4820.542048505386;4873.731944743073 17:12:47 INFO - PROCESS | 4337 | |4;prototype.html;317.6331337305413;324.69965282114043;326.8676186144612;327.62977835046394;331.3505529162841;5076.873078173043;5142.820001299955;5150.665206761558;5153.407358153804;5155.974220128899;4790.80836766529;4890.559849613534;5048.283583581581;5069.721165335905;5092.261622064799;3982.681385489154;4008.959910400888;4017.31705610047;4038.3336749436307;4044.777537235458;4019.678425725935;4029.6171863672903;4038.6365227129554;4043.6360727534516;4047;3771.5851256361916;3819.8663046793367;3966.8611598594057;3974.105826189099;3977.587956275524;3940.960590394088;3944.270309992632;3947.822347994347;3948.921021579581;3968.9007774805573;3523.119220194951;3524.1718196223865;3529.9294014119832;3535.7524973251884;3542.3446662367546;4756.78916731205;4816.060868130716;4844.10384078943;4850.75746212688;4850.781714822841;4568.406107206075;4570.817167313304;4598.540145985408;4607.654425918036;4607.861764147081;5302.549283310923;5318.095923692981;5322.467753224647;5327.227552004976;5350.796070884059;3738.2336620992633;3883.281592905293;3886.1839013807135;3887.688984881203;3888.2806680764147;5543.113101903676;5589.608727389084;5607.579431542651;5626.099824028177;5626.690532020737;3996.320625493615;4000.3199456092534;4002.199560087994;4005.459262999516;4010.1578668479365;3967.1668949520345;4069.3895915612893;4069.6337329640473;4071.982004498875;4086.611771881726;4576.771161441981;4584.908301834012;4586.151561961048;4597.908041839144;4598.149342371672;5341.092014357569;5355.839324820262;5359.517643412111;5370.91943620846;5381.165919282517;1329.634350553586;1380.3581334679423;1415.794709767078;1428.3358238418978;1432.7421064208543;965.3918031640022;968.0948313326921;976.4922240434934;988.6984469736799;989.9505024748734;4711.104890070944;4712.196243235269;4719.362886010414;4743.620510359163;4746.169420351424;5454.427285135083;5465.453454654503;5477.726113694379;5497;5504.394516603171;4548.74981876;4686.27362758773;4717.174494463455;4717.669763116617;4730.195866702668;2935.222166125978;2938.5445255985355;2950.601668774731;2951.793374463767;2957.364166704126;5171.482851714798;5172;5183.408295852074;5185.170372740344;5206.661566998208;5404.513593776579;5582.497575218169;5615.606907516516;5623.6906970116215;5637.098064309691;5157.406898206679;5161.148410512374;5162.638615296968;5166.095933211673;5182;5477.780888764564;5491.423400543045;5493.945060549343;5497.120460726424;5504.201890725903;5234.24103504982;5379.4351593082165;5510.862228444321;5536.280283563111;5541.916871246854;5294.523492885659;5296.761645726028;5300.833816560351;5314.741234975043;5318.494742999409;3890.988343030776;3900.6294402032895;3903.2193561288423;3908.0620651044114;3921.745086569364;5343.599230057684;5515;5583.218349431164;5616.494515493625;5619.157126431068;5146.279520867157;5357.116075847442;5367.141257398797;5399.43305952885;5416.4563099516445;5345.518903298722;5381.5694744421135;5385.38068122171;5396.298481197419;5400.702961337164;5153.45888681683;5310.575153987595;5311.336082989626;5326.813561525483;5342.813001544927;5376.489233522809;5412.350517937873;5432.619716619799;5443.346798384061;5448.101063324666;5266.710330931683;5268.552173065179;5269.920951185812;5270.947290527199;5287.365516138088 17:12:47 INFO - PROCESS | 4337 | |5;yui.html;646.8932626116691;686.5914780705482;706.8126946359214;736.4403053679206;758.9165191828898;11694.532218711252;11752.588659396912;11842.052635789116;11938.582149624764;11972.640820775368;11496.827547586792;11512.654620361382;11539.769204615903;11545.480453379598;11552.711182220448;635.152071983902;765.6937225109973;791.2957467853615;804.0552350987596;805.6696754330726;794.6503538443095;794.9880751788698;798.2695833312512;799.400449662753;800.0958916424461;856.5203486047802;856.8372009318241;857.4769390671685;858.6479543387212;859.0207163833235;676.3067855448156;824.4929368438427;844.079952851395;844.9028361738356;846.4371193156544;618.264265524025;620.4849974521181;625.8153844615804;625.859181684122;625.9467945224616;11481.081513478985;11576.826347604792;11582.131340149439;11590.652280431601;11603.593874214363;12126.878731212662;12127;12598.370081495888;12604.55884044054;12730.490780368775;9672.613095476172;9734.853977190347;9816.852747208797;9938.801223975552;10118.696439106838;3255.283837555734;3286.523454099166;3312.7846689965318;3351.782134161296;3402.625711171769;47719.522804771856;47737;47850.52149478495;47939.520604793855;48780;9465.90534094664;9476.147146756824;9731.56207970643;10140.645077422403;10143.492825358702;16233.107179105027;16371.508854734377;16393.59016024609;16418.097004664618;16458.83541164597;6396.072569477493;6502.089707440962;6564.80305590833;6596.604203747695;6603.966980165068;3633.3278343506536;3637.727170462226;3666.944995825065;3717.498137751369;3821.9426708599394;2794.8602569871423;2850.6009158717798;2853.571964205386;2872.2532141643323;2877.956830647542;519.1460048220731;521.0438844719905;522.334024119251;525.8291055407008;532.1990404441368;503.62983207342575;508.47626944247486;583.6983526735404;624.1012941364421;649.3928177154376;7320.560766354036;7553.093628764474;7588;7610.086789585174;7765.495242809199;444.5310197741414;499.6876951905059;501.32571691075447;562.9324481062299;563.8393057978457;3521.7006554442646;3717.981410092932;3761.8495260189834;3826.770393776382;3833.6358045985585;41439.58560414357;46122.76938615352;46302.305465418045;46327;48603.513964860605;38849;39504.604953950664;41388.965275868344;41774.37338439926;42013.57986420158;32560.34879302353;38746.03134921649;39015.21969560593;39231;39330;7540.924590754023;7649.349805266615;7696.538207707332;7725.111612164673;7821.765347039598;27533.724662753117;27837.304067398476;28470;28560;28862.422751544433;34371.31257374889;35155.472667910515;36079.45880811737;36936;37190.25619487541;10332.690019299433;10424.530896109542;10458.843117353093;10588.152947764314;10608.681739547827;11659.766804664028;11680;11987.280763154238;12141.817872731739;12216.144869859025;10446.52990615409;10594.682159535227;10724.088452481627;10888.782224355627;10941.398223097805;10584.206184536344;10628.202884783826;10632.681019569425;11078.778424431304;11078.889211107786;10402.583896644352;10514.369137851754;10592.523336450033;10618.8938110621;11252.212345135762;9791.657291994747;9807.803843923224;9848.113669769755;9894.257930655374;10159.7460063499;9469.880118635087;9740.75648108803;9801.460919649202;9801.705948821547;9927.106560409598 17:12:47 INFO - PROCESS | 4337 | __end_tp_report 17:12:47 INFO - PROCESS | 4337 | __start_cc_report 17:12:47 INFO - PROCESS | 4337 | _x_x_mozilla_cycle_collect,1145 17:12:48 INFO - PROCESS | 4337 | __end_cc_report 17:12:48 INFO - PROCESS | 4337 | __startTimestamp1460679167992__endTimestamp 17:12:48 INFO - PROCESS | 4337 | 17:12:48 INFO - PROCESS | 4337 | ------- Summary: start ------- 17:12:48 INFO - PROCESS | 4337 | Number of tests: 6 17:12:48 INFO - PROCESS | 4337 | 17:12:48 INFO - PROCESS | 4337 | [#0] dojo.html Cycles:165 Average:4654.89 Median:4771.83 stddev:478.71 (10.0%) stddev-sans-first:451.96 17:12:48 INFO - PROCESS | 4337 | Values: 2590.6 2695.1 2704.7 2710.2 2737.0 4645.0 4675.7 4711.4 4720.3 4735.6 4704.1 4714.5 4722.8 4750.1 4764.9 4244.8 4285.7 4314.1 4343.9 4453.0 4387.3 4397.8 4408.3 4454.8 4463.3 4180.2 4268.7 4323.5 4353.7 4382.4 4233.5 4312.7 4325.0 4362.3 4366.0 4234.9 4252.4 4254.1 4264.3 4294.7 4540.7 4566.5 4588.3 4607.3 4691.0 5021.8 5035.3 5039.9 5039.9 5066.2 5070.6 5075.6 5077.3 5086.4 5123.4 4588.0 4674.3 4702.7 4726.3 4770.1 5140.5 5148.6 5149.2 5164.2 5167.5 4946.0 4947.6 4948.6 4949.1 5000.5 4888.9 4974.4 5074.2 5089.6 5092.3 4950.2 4977.4 4979.8 4985.9 5034.3 4962.7 4966.7 4970.3 4971.0 5020.3 4178.2 4197.7 4260.3 4272.3 4275.8 3714.9 3719.8 3725.1 3764.2 3766.0 4391.8 4393.1 4395.1 4435.5 4439.8 4969.2 5026.7 5050.7 5096.3 5124.0 4388.1 4401.8 4403.1 4405.8 4434.5 4560.6 4568.0 4569.4 4570.9 4618.2 4594.0 4736.1 4789.5 4824.0 4831.2 5071.9 5087.0 5091.5 5095.0 5144.2 4638.1 4771.6 4771.8 4777.0 4779.0 4947.2 4955.1 4972.7 5016.5 5024.3 5014.4 5021.9 5026.5 5034.4 5080.5 4751.9 4868.1 4870.4 4873.0 4922.6 4872.5 4901.0 4905.9 4913.1 4934.6 4818.2 4820.2 4830.5 4831.7 4880.3 4737.2 4869.0 4962.5 4975.3 4975.8 4743.6 4780.1 4805.4 4832.9 4833.7 17:12:48 INFO - PROCESS | 4337 | 17:12:48 INFO - PROCESS | 4337 | [#1] ext.html Cycles:180 Average:41595.40 Median:33985.07 stddev:68793.24 (202.4%) stddev-sans-first:68917.23 17:12:48 INFO - PROCESS | 4337 | Values: 561.0 579.2 600.7 604.7 613.3 26292.7 32997.7 33508.5 33861.3 33926.8 36708.4 37279.4 37362.0 37530.4 37542.2 7277.1 7580.3 7763.4 7772.2 9304.2 9605.5 9802.7 9805.4 9810.8 9820.0 9753.1 9755.4 9836.4 9853.6 9860.8 9604.3 9777.3 9780.3 9785.3 9790.3 9634.6 10041.5 10049.7 10053.2 10061.0 37246.0 37615.6 37619.6 37644.1 38007.6 3105.6 3271.5 3563.0 3614.0 3615.8 28455.6 29231.9 29491.9 29687.4 30048.4 3431.8 3436.2 3514.6 3602.2 3615.0 168922.0 170979.0 171624.0 171656.1 172282.1 54552.2 55652.7 55713.0 55863.7 55885.0 58741.0 58869.0 59022.4 59041.7 59119.4 15070.4 15465.8 15504.5 15509.4 15514.5 11861.6 11938.4 11951.3 11953.9 11963.8 18863.2 19189.2 19218.0 19241.8 19318.3 7309.0 7322.4 7512.0 7565.2 7620.2 974.2 1004.3 1012.2 1052.8 1057.8 27765.7 27933.2 28219.9 28291.7 28401.9 984.5 1008.5 1010.2 1023.7 1029.5 14504.9 14968.2 15005.2 15297.6 15333.8 353482.0 353569.0 359798.0 360551.0 360832.0 48646.0 49214.3 49274.8 49466.5 49553.0 1117.3 1207.6 1222.7 1243.4 1261.4 24568.1 27101.9 27269.2 27762.4 27818.3 38175.4 38538.6 38565.2 38592.2 38671.4 215998.0 221830.0 222051.0 222429.0 222457.0 32139.0 37400.3 38172.8 38187.4 39286.6 36053.8 36382.6 36445.3 36460.8 37041.6 31179.4 31519.5 31935.5 32168.5 32481.4 32127.8 33426.0 33555.5 33814.3 34087.3 33164.8 33702.5 34043.3 34077.7 34102.8 29998.4 30401.7 30594.1 30659.0 30664.2 23491.4 23950.6 24101.8 24151.8 24274.5 17:12:48 INFO - PROCESS | 4337 | 17:12:48 INFO - PROCESS | 4337 | [#2] jquery.html Cycles:180 Average:23811.90 Median:21398.97 stddev:64161.63 (299.8%) stddev-sans-first:64317.51 17:12:48 INFO - PROCESS | 4337 | Values: 382.7 382.9 390.1 391.6 404.9 15874.0 17140.5 17276.8 17370.3 17383.5 16040.9 16243.3 16593.2 16904.3 16910.8 4937.4 5115.8 5137.3 5156.6 5158.7 3614.5 5622.9 5911.3 5972.5 5986.7 5838.7 5896.8 5908.6 5911.7 5940.2 5674.9 5809.9 5830.8 5846.1 5849.1 3329.9 3538.7 4934.3 5256.1 5256.8 18266.5 18830.6 18833.8 19216.9 19271.1 1954.0 1994.1 2229.8 2257.8 2260.8 12576.4 12969.1 13115.2 13467.1 13520.3 1755.6 1773.7 1788.9 1853.7 1854.5 65512.7 67597.0 67859.0 68633.7 68966.0 9583.2 9657.6 10206.4 10212.3 10684.8 13985.6 13985.7 14075.1 14079.5 14090.2 7255.7 7276.1 7357.9 7387.3 7468.6 6756.7 6797.1 6848.3 6875.7 6891.6 6093.0 6131.4 6133.4 6299.9 6426.3 1679.5 1744.4 1815.1 1844.4 1853.6 887.1 909.4 943.0 976.7 1033.9 16390.3 16399.6 16780.3 17294.5 17306.8 903.0 942.6 944.4 964.7 1003.2 9522.4 9632.9 9759.1 9891.8 9934.8 378652.0 381911.0 396287.0 396549.0 397914.0 68820.7 70162.6 71135.3 71509.0 71621.3 974.4 976.5 1004.4 1025.7 1026.5 15012.6 15072.3 15112.5 15281.5 15537.2 31805.2 31808.4 31913.0 32192.5 32454.0 42393.0 43339.3 43550.0 43582.3 44169.0 7270.6 7371.5 7386.2 7438.3 7482.9 10802.4 10842.1 11332.9 11464.5 11641.1 9960.6 10005.4 10014.6 10126.3 10279.7 9229.3 9657.1 9843.0 9883.0 10259.7 8568.5 9974.0 10122.7 10179.4 10206.0 7154.3 7169.8 7188.9 7343.8 7514.1 9948.9 9958.9 9981.1 10090.8 10256.8 17:12:48 INFO - PROCESS | 4337 | 17:12:48 INFO - PROCESS | 4337 | [#3] mootools.html Cycles:180 Average:5164.88 Median:5488.51 stddev:2863.17 (52.2%) stddev-sans-first:2856.53 17:12:48 INFO - PROCESS | 4337 | Values: 1308.4 1445.8 1488.8 1611.6 1780.8 7458.9 7771.2 7776.0 7776.2 7781.6 7752.7 7904.7 7904.8 7913.1 7915.8 2224.5 2251.2 2253.3 2256.8 2256.9 2202.9 2218.9 2240.1 2245.7 2246.5 2197.6 2199.6 2207.4 2207.6 2236.2 2148.0 2160.4 2167.7 2171.9 2174.8 2141.3 2145.1 2147.9 2148.1 2152.8 7710.8 7760.1 7812.8 7814.1 8004.4 4574.8 4716.3 4735.1 4751.0 4766.6 3034.2 3039.7 3102.5 3106.4 3115.9 973.6 987.4 1001.9 1021.3 1024.2 10580.2 10708.5 10712.9 10722.3 10739.6 4127.1 4219.4 4243.9 4246.7 4253.1 8502.5 8549.9 8552.1 8553.6 8561.5 4523.7 4529.5 4533.0 4547.2 4555.2 3701.3 3751.4 4200.7 4226.6 4227.1 3401.4 3448.8 3505.0 3509.1 3587.7 1049.6 1069.2 1070.1 1073.5 1087.5 859.9 880.3 882.3 886.4 904.4 5557.4 5571.2 5639.1 5714.0 5845.6 898.3 904.4 934.8 947.1 956.0 3465.4 3738.5 3765.4 3771.8 3774.1 9421.8 9719.6 9744.9 9895.6 9969.3 9755.8 9834.3 9874.4 9946.4 9948.6 7360.9 7394.9 7526.8 7616.0 7639.5 5370.7 5374.4 5451.5 5525.5 5750.3 8925.6 9088.5 9122.5 9149.3 9199.3 8632.1 8832.3 8926.0 8931.2 8936.6 6110.5 6601.9 6648.7 6805.0 6813.4 7291.7 7373.0 7404.0 7426.3 7435.2 6465.2 6495.3 6499.2 6505.1 6849.1 6374.9 6378.9 6499.2 6549.6 6664.4 6339.5 6342.2 6356.2 6360.0 6380.2 4572.5 4687.8 4720.3 4781.4 4785.6 4625.9 4749.3 4815.5 4820.5 4873.7 17:12:48 INFO - PROCESS | 4337 | 17:12:48 INFO - PROCESS | 4337 | [#4] prototype.html Cycles:180 Average:4460.84 Median:5117.54 stddev:1281.49 (25.0%) stddev-sans-first:1246.79 17:12:48 INFO - PROCESS | 4337 | Values: 317.6 324.7 326.9 327.6 331.4 5076.9 5142.8 5150.7 5153.4 5156.0 4790.8 4890.6 5048.3 5069.7 5092.3 3982.7 4009.0 4017.3 4038.3 4044.8 4019.7 4029.6 4038.6 4043.6 4047.0 3771.6 3819.9 3966.9 3974.1 3977.6 3941.0 3944.3 3947.8 3948.9 3968.9 3523.1 3524.2 3529.9 3535.8 3542.3 4756.8 4816.1 4844.1 4850.8 4850.8 4568.4 4570.8 4598.5 4607.7 4607.9 5302.5 5318.1 5322.5 5327.2 5350.8 3738.2 3883.3 3886.2 3887.7 3888.3 5543.1 5589.6 5607.6 5626.1 5626.7 3996.3 4000.3 4002.2 4005.5 4010.2 3967.2 4069.4 4069.6 4072.0 4086.6 4576.8 4584.9 4586.2 4597.9 4598.1 5341.1 5355.8 5359.5 5370.9 5381.2 1329.6 1380.4 1415.8 1428.3 1432.7 965.4 968.1 976.5 988.7 990.0 4711.1 4712.2 4719.4 4743.6 4746.2 5454.4 5465.5 5477.7 5497.0 5504.4 4548.7 4686.3 4717.2 4717.7 4730.2 2935.2 2938.5 2950.6 2951.8 2957.4 5171.5 5172.0 5183.4 5185.2 5206.7 5404.5 5582.5 5615.6 5623.7 5637.1 5157.4 5161.1 5162.6 5166.1 5182.0 5477.8 5491.4 5493.9 5497.1 5504.2 5234.2 5379.4 5510.9 5536.3 5541.9 5294.5 5296.8 5300.8 5314.7 5318.5 3891.0 3900.6 3903.2 3908.1 3921.7 5343.6 5515.0 5583.2 5616.5 5619.2 5146.3 5357.1 5367.1 5399.4 5416.5 5345.5 5381.6 5385.4 5396.3 5400.7 5153.5 5310.6 5311.3 5326.8 5342.8 5376.5 5412.4 5432.6 5443.3 5448.1 5266.7 5268.6 5269.9 5270.9 5287.4 17:12:48 INFO - PROCESS | 4337 | 17:12:48 INFO - PROCESS | 4337 | [#5] yui.html Cycles:180 Average:12101.64 Median:40446.79 stddev:13308.27 (32.9%) stddev-sans-first:13317.80 17:12:48 INFO - PROCESS | 4337 | Values: 646.9 686.6 706.8 736.4 758.9 11694.5 11752.6 11842.1 11938.6 11972.6 11496.8 11512.7 11539.8 11545.5 11552.7 635.2 765.7 791.3 804.1 805.7 794.7 795.0 798.3 799.4 800.1 856.5 856.8 857.5 858.6 859.0 676.3 824.5 844.1 844.9 846.4 618.3 620.5 625.8 625.9 625.9 11481.1 11576.8 11582.1 11590.7 11603.6 12126.9 12127.0 12598.4 12604.6 12730.5 9672.6 9734.9 9816.9 9938.8 10118.7 3255.3 3286.5 3312.8 3351.8 3402.6 47719.5 47737.0 47850.5 47939.5 48780.0 9465.9 9476.1 9731.6 10140.6 10143.5 16233.1 16371.5 16393.6 16418.1 16458.8 6396.1 6502.1 6564.8 6596.6 6604.0 3633.3 3637.7 3666.9 3717.5 3821.9 2794.9 2850.6 2853.6 2872.3 2878.0 519.1 521.0 522.3 525.8 532.2 503.6 508.5 583.7 624.1 649.4 7320.6 7553.1 7588.0 7610.1 7765.5 444.5 499.7 501.3 562.9 563.8 3521.7 3718.0 3761.8 3826.8 3833.6 41439.6 46122.8 46302.3 46327.0 48603.5 38849.0 39504.6 41389.0 41774.4 42013.6 32560.3 38746.0 39015.2 39231.0 39330.0 7540.9 7649.3 7696.5 7725.1 7821.8 27533.7 27837.3 28470.0 28560.0 28862.4 34371.3 35155.5 36079.5 36936.0 37190.3 10332.7 10424.5 10458.8 10588.2 10608.7 11659.8 11680.0 11987.3 12141.8 12216.1 10446.5 10594.7 10724.1 10888.8 10941.4 10584.2 10628.2 10632.7 11078.8 11078.9 10402.6 10514.4 10592.5 10618.9 11252.2 9791.7 9807.8 9848.1 9894.3 10159.7 9469.9 9740.8 9801.5 9801.7 9927.1 17:12:48 INFO - PROCESS | 4337 | -------- Summary: end -------- 17:12:48 INFO - PROCESS | 4337 | 17:12:48 INFO - TEST-INFO | 4337: exit 0 17:12:48 INFO - TEST-OK | dromaeo_css | took 1118758ms 17:12:48 INFO - TEST-START | kraken 17:12:48 INFO - operating with platform_type : linux_ 17:12:48 INFO - Initialising browser for kraken test... 17:12:48 INFO - TEST-INFO | started process 4519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Bjn43/profile http://localhost:41316/getInfo.html) 17:12:53 INFO - PROCESS | 4519 | __metrics Screen width/height:1600/1200 17:12:53 INFO - PROCESS | 4519 | colorDepth:24 17:12:53 INFO - PROCESS | 4519 | Browser inner width/height: 1024/697 17:12:53 INFO - PROCESS | 4519 | __metrics 17:12:54 ERROR - PROCESS | 4519 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:12:55 INFO - TEST-INFO | 4519: exit 0 17:12:55 INFO - Browser initialized. 17:12:55 INFO - Running cycle 1/1 for kraken test... 17:12:55 INFO - TEST-INFO | started process 4599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Bjn43/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:07 INFO - PROCESS | 4599 | RSS: Main: 154509312 17:13:07 INFO - PROCESS | 4599 | 17:13:09 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41316/tests/kraken/driver.html?testName=audio-beat-detection) 17:13:10 INFO - PROCESS | 4599 | RSS: Main: 210223104 17:13:10 INFO - PROCESS | 4599 | 17:13:13 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41316/tests/kraken/driver.html?testName=audio-dft) 17:13:14 INFO - PROCESS | 4599 | RSS: Main: 194859008 17:13:14 INFO - PROCESS | 4599 | 17:13:17 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41316/tests/kraken/driver.html?testName=audio-fft) 17:13:17 INFO - PROCESS | 4599 | RSS: Main: 265744384 17:13:17 INFO - PROCESS | 4599 | 17:13:20 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41316/tests/kraken/driver.html?testName=audio-oscillator) 17:13:20 INFO - PROCESS | 4599 | RSS: Main: 173916160 17:13:20 INFO - PROCESS | 4599 | 17:13:22 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:13:23 INFO - PROCESS | 4599 | RSS: Main: 178225152 17:13:23 INFO - PROCESS | 4599 | 17:13:26 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41316/tests/kraken/driver.html?testName=imaging-darkroom) 17:13:27 INFO - PROCESS | 4599 | RSS: Main: 213979136 17:13:27 INFO - PROCESS | 4599 | 17:13:30 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41316/tests/kraken/driver.html?testName=imaging-desaturate) 17:13:31 INFO - PROCESS | 4599 | RSS: Main: 214462464 17:13:31 INFO - PROCESS | 4599 | 17:13:34 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41316/tests/kraken/driver.html?testName=json-parse-financial) 17:13:34 INFO - PROCESS | 4599 | RSS: Main: 214622208 17:13:34 INFO - PROCESS | 4599 | 17:13:36 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:36 INFO - PROCESS | 4599 | RSS: Main: 201064448 17:13:36 INFO - PROCESS | 4599 | 17:13:38 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41316/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:39 INFO - PROCESS | 4599 | RSS: Main: 203624448 17:13:39 INFO - PROCESS | 4599 | 17:13:41 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:13:42 INFO - PROCESS | 4599 | RSS: Main: 219570176 17:13:42 INFO - PROCESS | 4599 | 17:13:45 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:13:45 INFO - PROCESS | 4599 | RSS: Main: 224960512 17:13:45 INFO - PROCESS | 4599 | 17:13:48 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:49 INFO - PROCESS | 4599 | RSS: Main: 217001984 17:13:49 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | Cycle 1(1): loaded http://localhost:41316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41316/tests/kraken/driver.html?testName=ai-astar) 17:13:51 INFO - PROCESS | 4599 | RSS: Main: 280551424 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | __start_tp_report 17:13:51 INFO - PROCESS | 4599 | _x_x_mozilla_page_load 17:13:51 INFO - PROCESS | 4599 | _x_x_mozilla_page_load_details 17:13:51 INFO - PROCESS | 4599 | |i|pagename|runs| 17:13:51 INFO - PROCESS | 4599 | |0;ai-astar;110;112;106;112;114;114;102;112;112;112 17:13:51 INFO - PROCESS | 4599 | |1;audio-beat-detection;169;137;161;177;134;160;161;139;188;132 17:13:51 INFO - PROCESS | 4599 | |2;audio-dft;162;161;160;162;161;163;161;161;162;162 17:13:51 INFO - PROCESS | 4599 | |3;audio-fft;73;73;110;103;73;73;73;129;103;73 17:13:51 INFO - PROCESS | 4599 | |4;audio-oscillator;94;93;146;93;94;93;136;94;94;148 17:13:51 INFO - PROCESS | 4599 | |5;imaging-gaussian-blur;117;118;117;117;116;117;118;117;116;116 17:13:51 INFO - PROCESS | 4599 | |6;imaging-darkroom;146;146;146;145;146;146;146;145;146;146 17:13:51 INFO - PROCESS | 4599 | |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;95 17:13:51 INFO - PROCESS | 4599 | |8;json-parse-financial;64;66;66;67;66;65;64;82;63;63 17:13:51 INFO - PROCESS | 4599 | |9;json-stringify-tinderbox;64;65;64;64;64;65;64;65;64;70 17:13:51 INFO - PROCESS | 4599 | |10;stanford-crypto-aes;90;85;84;84;85;84;84;84;85;84 17:13:51 INFO - PROCESS | 4599 | |11;stanford-crypto-ccm;141;139;146;144;139;135;146;139;169;147 17:13:51 INFO - PROCESS | 4599 | |12;stanford-crypto-pbkdf2;172;171;171;173;171;188;172;172;171;171 17:13:51 INFO - PROCESS | 4599 | |13;stanford-crypto-sha256-iterative;73;73;72;75;74;71;72;72;72;77 17:13:51 INFO - PROCESS | 4599 | __end_tp_report 17:13:51 INFO - PROCESS | 4599 | __start_cc_report 17:13:51 INFO - PROCESS | 4599 | _x_x_mozilla_cycle_collect,1878 17:13:51 INFO - PROCESS | 4599 | __end_cc_report 17:13:51 INFO - PROCESS | 4599 | __startTimestamp1460679231344__endTimestamp 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | ------- Summary: start ------- 17:13:51 INFO - PROCESS | 4599 | Number of tests: 14 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.78 (3.4%) stddev-sans-first:4.00 17:13:51 INFO - PROCESS | 4599 | Values: 110.0 112.0 106.0 112.0 114.0 114.0 102.0 112.0 112.0 112.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:161.00 stddev:19.46 (12.1%) stddev-sans-first:20.05 17:13:51 INFO - PROCESS | 4599 | Values: 169.0 137.0 161.0 177.0 134.0 160.0 161.0 139.0 188.0 132.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 17:13:51 INFO - PROCESS | 4599 | Values: 162.0 161.0 160.0 162.0 161.0 163.0 161.0 161.0 162.0 162.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#3] audio-fft Cycles:10 Average:88.30 Median:73.00 stddev:20.99 (28.7%) stddev-sans-first:21.52 17:13:51 INFO - PROCESS | 4599 | Values: 73.0 73.0 110.0 103.0 73.0 73.0 73.0 129.0 103.0 73.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.50 stddev:24.23 (25.9%) stddev-sans-first:25.13 17:13:51 INFO - PROCESS | 4599 | Values: 94.0 93.0 146.0 93.0 94.0 93.0 136.0 94.0 94.0 148.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 17:13:51 INFO - PROCESS | 4599 | Values: 117.0 118.0 117.0 117.0 116.0 117.0 118.0 117.0 116.0 116.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 17:13:51 INFO - PROCESS | 4599 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:13:51 INFO - PROCESS | 4599 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:66.00 stddev:5.58 (8.5%) stddev-sans-first:5.84 17:13:51 INFO - PROCESS | 4599 | Values: 64.0 66.0 66.0 67.0 66.0 65.0 64.0 82.0 63.0 63.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:64.50 stddev:1.85 (2.9%) stddev-sans-first:1.94 17:13:51 INFO - PROCESS | 4599 | Values: 64.0 65.0 64.0 64.0 64.0 65.0 64.0 65.0 64.0 70.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:1.85 (2.2%) stddev-sans-first:0.50 17:13:51 INFO - PROCESS | 4599 | Values: 90.0 85.0 84.0 84.0 85.0 84.0 84.0 84.0 85.0 84.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:145.00 stddev:9.45 (6.5%) stddev-sans-first:9.94 17:13:51 INFO - PROCESS | 4599 | Values: 141.0 139.0 146.0 144.0 139.0 135.0 146.0 139.0 169.0 147.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:172.00 stddev:5.25 (3.0%) stddev-sans-first:5.55 17:13:51 INFO - PROCESS | 4599 | Values: 172.0 171.0 171.0 173.0 171.0 188.0 172.0 172.0 171.0 171.0 17:13:51 INFO - PROCESS | 4599 | 17:13:51 INFO - PROCESS | 4599 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.00 stddev:1.79 (2.5%) stddev-sans-first:1.90 17:13:51 INFO - PROCESS | 4599 | Values: 73.0 73.0 72.0 75.0 74.0 71.0 72.0 72.0 72.0 77.0 17:13:51 INFO - PROCESS | 4599 | -------- Summary: end -------- 17:13:51 INFO - PROCESS | 4599 | 17:13:52 INFO - TEST-INFO | 4599: exit 0 17:13:52 INFO - TEST-OK | kraken | took 63619ms 17:13:52 INFO - SUITE-END | took 1182s 17:13:52 INFO - Completed test suite (00:19:42) 17:13:52 INFO - javascript benchmark 17:13:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.5984572391276, 2695.110613497545, 2704.7160048194937, 2710.2411324829054, 2737.0146747171016, 4645.0, 4675.672702910798, 4711.363965864607, 4720.291956206566, 4735.621150307976, 4704.106219818232, 4714.481407045222, 4722.763861806913, 4750.073735621547, 4764.857054288377, 4244.83020679174, 4285.742855428676, 4314.0509088000745, 4343.869683909472, 4453.020335526196, 4387.276099443588, 4397.780110994453, 4408.272635015219, 4454.821807127727, 4463.3081872309685, 4180.226658068267, 4268.722533035374, 4323.481182258118, 4353.673474489426, 4382.4302840630835, 4233.491980962273, 4312.676549258818, 4324.978375108104, 4362.258416069276, 4365.978170109129, 4234.936475952833, 4252.447181866369, 4254.085371645111, 4264.275073237526, 4294.656427485794, 4540.704854184501, 4566.497685254652, 4588.334691469751, 4607.262837945913, 4690.9530904690855, 5021.84934451967, 5035.320231768701, 5039.949600503985, 5039.949600503985, 5066.189409694468, 5070.569001634865, 5075.5939524838295, 5077.314562534085, 5086.415062267813, 5123.359580052494, 4588.036512332381, 4674.345591617176, 4702.717836929761, 4726.291056341576, 4770.069836381872, 5140.511651393112, 5148.562372198405, 5149.2276158576515, 5164.1995490699, 5167.4832516748775, 4945.975270123627, 4947.5794557462295, 4948.628852836052, 4949.133901567211, 5000.474950130184, 4888.926666100011, 4974.353334066548, 5074.162763144113, 5089.592832573459, 5092.28707980883, 4950.2079667253065, 4977.377827771528, 4979.775910084055, 4985.850424487271, 5034.345535080416, 4962.652614316963, 4966.652334336634, 4970.2793095001025, 4971.0, 5020.2720605511995, 4178.247915375262, 4197.748135111903, 4260.2970509866145, 4272.316429371285, 4275.8075886585175, 3714.925701485955, 3719.75821571597, 3725.0501122214205, 3764.1906989997283, 3766.039659886766, 4391.8462853799965, 4393.143337049245, 4395.099004704028, 4435.467743870756, 4439.755813430293, 4969.18008528596, 5026.748662566857, 5050.747462626854, 5096.337476128154, 5124.0, 4388.0785035142335, 4401.801918913657, 4403.053343531092, 4405.845795397146, 4434.512203657595, 4560.566746159176, 4567.972206253633, 4569.428821397325, 4570.9314360284625, 4618.1918164321105, 4593.954060459419, 4736.052789442194, 4789.544993225638, 4824.0, 4831.227003679394, 5071.87320316995, 5086.9745651271505, 5091.490850914879, 5095.0, 5144.228365745168, 4638.1187574360765, 4771.618270538418, 4771.832985845479, 4776.95223047779, 4779.044191161712, 4947.233178857283, 4955.083309587738, 4972.676776009548, 5016.498350164954, 5024.271480635361, 5014.398272207359, 5021.899562008813, 5026.472220416804, 5034.421041580119, 5080.542751152266, 4751.928721069117, 4868.123737727243, 4870.391201099863, 4873.0, 4922.581580565548, 4872.4883887192755, 4900.95099049005, 4905.852824415273, 4913.140200464976, 4934.55588996992, 4818.156822556109, 4820.1805693031565, 4830.468648448738, 4831.685940413862, 4880.267959806058, 4737.170995075917, 4868.9756551217015, 4962.503749625153, 4975.328330675313, 4975.776090075883, 4743.620510359094, 4780.067886762048, 4805.423349198119, 4832.879178020437, 4833.709977401367], "value": 4625.209719189732, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.0015062100299, 579.1920271221645, 600.6786369292427, 604.7218279591385, 613.3130893399393, 26292.73707262927, 32997.67002329976, 33508.49737253943, 33861.32277354451, 33926.8303658482, 36708.449373259355, 37279.440808387895, 37362.0, 37530.43704344437, 37542.249155016885, 7277.090363704537, 7580.279873412017, 7763.378929685611, 7772.183920688331, 9304.162625363715, 9605.519724013771, 9802.656907008257, 9805.36265142767, 9810.754731131707, 9820.0, 9753.122219000288, 9755.365901216433, 9836.409815411098, 9853.556589953434, 9860.802783944317, 9604.279679024066, 9777.266704997082, 9780.266480014028, 9785.315027948047, 9790.265730070238, 9634.614615415376, 10041.49792510379, 10049.748756281078, 10053.246006549538, 10060.993900609954, 37246.0, 37615.62384376149, 37619.62380376216, 37644.05889852748, 38007.61992380068, 3105.596272484585, 3271.5419841222247, 3562.964370356315, 3614.0, 3615.8192090395637, 28455.57316640252, 29231.853840730873, 29491.852540737375, 29687.406251875058, 30048.399032019457, 3431.77052462755, 3436.1581412554083, 3514.648535146465, 3602.1534939289245, 3615.0, 168922.0, 170979.0, 171624.0, 171656.14171929186, 172282.13858930624, 54552.181717274274, 55652.72173639106, 55713.0, 55863.720681396335, 55885.0, 58741.0, 58869.0, 59022.40977590255, 59041.70479147663, 59119.40880591225, 15070.438025535685, 15465.845341546441, 15504.534863954099, 15509.379624814881, 15514.456994005155, 11861.5848445304, 11938.403079845973, 11951.282923024646, 11953.940230298793, 11963.760724785456, 18863.245470181315, 19189.232430702894, 19218.0, 19241.849283770025, 19318.32385866488, 7309.0, 7322.3775979042375, 7511.9624401877645, 7565.243475652501, 7620.1998790127345, 974.2157563161722, 1004.3271008424373, 1012.1700205831148, 1052.8210204265292, 1057.7567159553191, 27765.722342776717, 27933.16200513988, 28219.858900705363, 28291.71708282891, 28401.857990709916, 984.5274268351232, 1008.4655132779639, 1010.2019404670228, 1023.7287118913493, 1029.5367084811865, 14504.927475362767, 14968.17675027862, 15005.249737513299, 15297.6175595611, 15333.769993450107, 353482.0, 353569.0, 359798.0, 360551.0, 360832.0, 48646.0, 49214.293213872865, 49274.7681307963, 49466.50533494691, 49553.0, 1117.2514415341577, 1207.6256360528264, 1222.7065504279087, 1243.4280231093617, 1261.369315342329, 24568.140115095885, 27101.86449067742, 27269.181924542296, 27762.444751105268, 27818.304542386602, 38175.427368588935, 38538.614613853504, 38565.22869542649, 38592.2281554373, 38671.41992870165, 215998.0, 221830.0, 222051.0, 222429.0, 222457.0, 32139.0, 37400.25199496049, 38172.809135955256, 38187.42718859275, 39286.607133929436, 36053.81973090118, 36382.63617363898, 36445.27109457743, 36460.81769591135, 37041.62958370382, 31179.37641247117, 31519.52720709237, 31935.520967185046, 32168.517472238404, 32481.350372991936, 32127.839360803046, 33426.0, 33555.496667549516, 33814.323713526086, 34087.31825363528, 33164.83417582897, 33702.49446258259, 34043.31913361768, 34077.65922340844, 34102.82948585241, 29998.400031999674, 30401.69598303989, 30594.08217753471, 30659.0, 30664.233394165323, 23491.41271468227, 23950.56296622208, 24101.758982409952, 24151.758482414953, 24274.51450971006], "value": 17662.792500899297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.6747264824899, 382.93107240696673, 390.0910877655064, 391.6240409207161, 404.9392591111331, 15874.0, 17140.485785426426, 17276.82723172768, 17370.305187792488, 17383.47849564512, 16040.919795401036, 16243.269052892618, 16593.170341482906, 16904.323827046905, 16910.83089169108, 4937.358143441356, 5115.846524604268, 5137.3064636274, 5156.613254005964, 5158.716270605115, 3614.475900994354, 5622.859428514299, 5911.290645122592, 5972.492338151263, 5986.730597123118, 5838.737256823453, 5896.764129434839, 5908.645481271137, 5911.73397197125, 5940.168376427304, 5674.858128546799, 5809.8547536311935, 5830.82507524775, 5846.123081537782, 5849.093390524476, 3329.93340133196, 3538.681518663307, 4934.333864928225, 5256.132738098209, 5256.843494431219, 18266.452006439697, 18830.623387532174, 18833.81166188334, 19216.903915480332, 19271.13279902408, 1953.990230048855, 1994.0926878270352, 2229.7881701238357, 2257.7967982881455, 2260.8191344692386, 12576.371181440983, 12969.092163548556, 13115.213087214797, 13467.12463689857, 13520.323983800869, 1755.5962128710469, 1773.725072613747, 1788.9284428622839, 1853.7497437845852, 1854.46220596027, 65512.67243663751, 67597.0, 67859.0, 68633.65683171603, 68966.0, 9583.233341332676, 9657.565409556586, 10206.387616743019, 10212.336198147097, 10684.839727404094, 13985.58043258704, 13985.72028559423, 14075.085119467201, 14079.507217247346, 14090.225037622824, 7255.673494692752, 7276.126864776261, 7357.852842943218, 7387.2612738726775, 7468.551886886804, 6756.695948682321, 6797.0823938767635, 6848.3494068063455, 6875.690593923286, 6891.552049116792, 6093.0, 6131.417515336036, 6133.417325354084, 6299.874002520016, 6426.260979987268, 1679.4541773923524, 1744.4069016534438, 1815.1015247452594, 1844.4097888675763, 1853.6478069166815, 887.0818702642863, 909.3543584055262, 942.9764255893657, 976.7069879036261, 1033.8914413986574, 16390.26243819031, 16399.590010249838, 16780.328786848633, 17294.481165565052, 17306.826931730775, 902.9729108126767, 942.5946842857637, 944.3908678902206, 964.6816550538306, 1003.242551873331, 9522.381045232038, 9632.90367096334, 9759.12167904892, 9891.752706182258, 9934.819488675246, 378652.0, 381911.0, 396287.0, 396549.0, 397914.0, 68820.6558967212, 70162.64918675374, 71135.28864711287, 71509.0, 71621.28378716251, 974.3958745577787, 976.4580657735025, 1004.4324956399611, 1025.687165414541, 1026.4764969865273, 15012.624684382978, 15072.321745521258, 15112.546623601309, 15281.541553753405, 15537.22313884324, 31805.20486987844, 31808.36383272368, 31913.0, 32192.517112242866, 32454.0, 42393.0, 43339.34990975201, 43550.0, 43582.34626480542, 44169.0, 7270.563766173835, 7371.483996120434, 7386.15059268191, 7438.293362130589, 7482.887756683763, 10802.351858888493, 10842.132629389473, 11332.886671133183, 11464.484098215768, 11641.06871450265, 9960.601575936882, 10005.399676019462, 10014.64948726791, 10126.341787783771, 10279.691609251735, 9229.307801915018, 9657.130858222794, 9842.950785246314, 9883.01169883006, 10259.7435064124, 8568.543347630794, 9973.950130249303, 10122.746931326776, 10179.440130792582, 10206.0, 7154.320339567733, 7169.7849064528145, 7188.8921666174, 7343.816404589928, 7514.098308203051, 9948.850767238353, 9958.900410995797, 9981.051800078982, 10090.848637270594, 10256.794864102527], "value": 8297.98286704639, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.3654427602605, 1445.797588337633, 1488.813898262717, 1611.6293252551914, 1780.777402824647, 7458.888116678248, 7771.184025677308, 7776.0, 7776.222377762221, 7781.572013539253, 7752.651130699118, 7904.683812647501, 7904.841903161933, 7913.089994650617, 7915.8416831663335, 2224.4661281292533, 2251.2458326460655, 2253.324002799162, 2256.7630398808137, 2256.8871556422196, 2202.944926376845, 2218.911243550256, 2240.09276243121, 2245.663150527426, 2246.4945387287894, 2197.6483762597986, 2199.6260635691892, 2207.39296693409, 2207.602631526325, 2236.1726161320335, 2148.033384976751, 2160.4274867160216, 2167.674848772681, 2171.8588291761066, 2174.826013918883, 2141.271967531047, 2145.066895900273, 2147.9463013424634, 2148.1192710988576, 2152.7847215278503, 7710.845783084363, 7760.107587627383, 7812.765617031499, 7814.0623125224765, 8004.3996700247135, 4574.817007319703, 4716.292556116576, 4735.100330937111, 4750.976245118787, 4766.594839438617, 3034.2111051126644, 3039.696030396965, 3102.472579661463, 3106.3942531206426, 3115.890943816978, 973.5764942250144, 987.3779518903045, 1001.8998100189996, 1021.3157184686204, 1024.1806554756165, 10580.206484513692, 10708.51811668469, 10712.946435267851, 10722.303050301627, 10739.570417183304, 4127.080907378084, 4219.409282700424, 4243.851465198703, 4246.681498887596, 4253.128108737701, 8502.532360720219, 8549.871751923725, 8552.102029286836, 8553.615087321086, 8561.48631082137, 4523.660725445605, 4529.547045295444, 4533.0, 4547.181507328646, 4555.2256116460285, 3701.3337599232395, 3751.381022131318, 4200.7479551227025, 4226.647472808671, 4227.133437645275, 3401.4387626041425, 3448.793072415663, 3505.0, 3509.052555809968, 3587.695045921074, 1049.569676432659, 1069.1660504806264, 1070.0583486531802, 1073.4954571351452, 1087.516055355375, 859.8581234096429, 880.300161371711, 882.3073886998675, 886.3972498700946, 904.3579058868146, 5557.360903496069, 5571.247881535941, 5639.125935480007, 5714.028615135437, 5845.620034697731, 898.3266561350174, 904.3669431398048, 934.7663084228943, 947.0576776107816, 955.9808803823885, 3465.4108801503803, 3738.4579236010627, 3765.3975363941636, 3771.773693578394, 3774.0753515388906, 9421.76445588852, 9719.56261968213, 9744.90255097454, 9895.554700038372, 9969.252306077073, 9755.756106097262, 9834.311598188058, 9874.40753554789, 9946.35348702332, 9948.602055917827, 7360.926390736131, 7394.852102957911, 7526.849463010819, 7616.04799400075, 7639.503432276884, 5370.704611246419, 5374.360819949797, 5451.48210919962, 5525.530329922001, 5750.252467179407, 8925.553722313989, 9088.500132492512, 9122.452652840851, 9149.268058555434, 9199.310051746012, 8632.136786321318, 8832.337574682053, 8926.0, 8931.151540603632, 8936.642534298555, 6110.480609148272, 6601.933980660324, 6648.667566621746, 6805.0472933788315, 6813.3527314905, 7291.671874765542, 7373.0, 7404.0, 7426.257374262531, 7435.182129965591, 6465.191851018622, 6495.253045899593, 6499.1876015498065, 6505.0567667688865, 6849.1096157499205, 6374.90437643445, 6378.872422551616, 6499.2200935887995, 6549.574277671936, 6664.366885145903, 6339.492840572835, 6342.207224096988, 6356.2054743157105, 6360.0, 6380.170577824853, 4572.45130584332, 4687.835925742583, 4720.291956206459, 4781.42622885256, 4785.641076919175, 4625.862461517129, 4749.26386410107, 4815.542523460265, 4820.542048505386, 4873.731944743073], "value": 4181.471367630057, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.6331337305413, 324.69965282114043, 326.8676186144612, 327.62977835046394, 331.3505529162841, 5076.873078173043, 5142.820001299955, 5150.665206761558, 5153.407358153804, 5155.974220128899, 4790.80836766529, 4890.559849613534, 5048.283583581581, 5069.721165335905, 5092.261622064799, 3982.681385489154, 4008.959910400888, 4017.31705610047, 4038.3336749436307, 4044.777537235458, 4019.678425725935, 4029.6171863672903, 4038.6365227129554, 4043.6360727534516, 4047.0, 3771.5851256361916, 3819.8663046793367, 3966.8611598594057, 3974.105826189099, 3977.587956275524, 3940.960590394088, 3944.270309992632, 3947.822347994347, 3948.921021579581, 3968.9007774805573, 3523.119220194951, 3524.1718196223865, 3529.9294014119832, 3535.7524973251884, 3542.3446662367546, 4756.78916731205, 4816.060868130716, 4844.10384078943, 4850.75746212688, 4850.781714822841, 4568.406107206075, 4570.817167313304, 4598.540145985408, 4607.654425918036, 4607.861764147081, 5302.549283310923, 5318.095923692981, 5322.467753224647, 5327.227552004976, 5350.796070884059, 3738.2336620992633, 3883.281592905293, 3886.1839013807135, 3887.688984881203, 3888.2806680764147, 5543.113101903676, 5589.608727389084, 5607.579431542651, 5626.099824028177, 5626.690532020737, 3996.320625493615, 4000.3199456092534, 4002.199560087994, 4005.459262999516, 4010.1578668479365, 3967.1668949520345, 4069.3895915612893, 4069.6337329640473, 4071.982004498875, 4086.611771881726, 4576.771161441981, 4584.908301834012, 4586.151561961048, 4597.908041839144, 4598.149342371672, 5341.092014357569, 5355.839324820262, 5359.517643412111, 5370.91943620846, 5381.165919282517, 1329.634350553586, 1380.3581334679423, 1415.794709767078, 1428.3358238418978, 1432.7421064208543, 965.3918031640022, 968.0948313326921, 976.4922240434934, 988.6984469736799, 989.9505024748734, 4711.104890070944, 4712.196243235269, 4719.362886010414, 4743.620510359163, 4746.169420351424, 5454.427285135083, 5465.453454654503, 5477.726113694379, 5497.0, 5504.394516603171, 4548.74981876, 4686.27362758773, 4717.174494463455, 4717.669763116617, 4730.195866702668, 2935.222166125978, 2938.5445255985355, 2950.601668774731, 2951.793374463767, 2957.364166704126, 5171.482851714798, 5172.0, 5183.408295852074, 5185.170372740344, 5206.661566998208, 5404.513593776579, 5582.497575218169, 5615.606907516516, 5623.6906970116215, 5637.098064309691, 5157.406898206679, 5161.148410512374, 5162.638615296968, 5166.095933211673, 5182.0, 5477.780888764564, 5491.423400543045, 5493.945060549343, 5497.120460726424, 5504.201890725903, 5234.24103504982, 5379.4351593082165, 5510.862228444321, 5536.280283563111, 5541.916871246854, 5294.523492885659, 5296.761645726028, 5300.833816560351, 5314.741234975043, 5318.494742999409, 3890.988343030776, 3900.6294402032895, 3903.2193561288423, 3908.0620651044114, 3921.745086569364, 5343.599230057684, 5515.0, 5583.218349431164, 5616.494515493625, 5619.157126431068, 5146.279520867157, 5357.116075847442, 5367.141257398797, 5399.43305952885, 5416.4563099516445, 5345.518903298722, 5381.5694744421135, 5385.38068122171, 5396.298481197419, 5400.702961337164, 5153.45888681683, 5310.575153987595, 5311.336082989626, 5326.813561525483, 5342.813001544927, 5376.489233522809, 5412.350517937873, 5432.619716619799, 5443.346798384061, 5448.101063324666, 5266.710330931683, 5268.552173065179, 5269.920951185812, 5270.947290527199, 5287.365516138088], "value": 4060.6728548672213, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.8932626116691, 686.5914780705482, 706.8126946359214, 736.4403053679206, 758.9165191828898, 11694.532218711252, 11752.588659396912, 11842.052635789116, 11938.582149624764, 11972.640820775368, 11496.827547586792, 11512.654620361382, 11539.769204615903, 11545.480453379598, 11552.711182220448, 635.152071983902, 765.6937225109973, 791.2957467853615, 804.0552350987596, 805.6696754330726, 794.6503538443095, 794.9880751788698, 798.2695833312512, 799.400449662753, 800.0958916424461, 856.5203486047802, 856.8372009318241, 857.4769390671685, 858.6479543387212, 859.0207163833235, 676.3067855448156, 824.4929368438427, 844.079952851395, 844.9028361738356, 846.4371193156544, 618.264265524025, 620.4849974521181, 625.8153844615804, 625.859181684122, 625.9467945224616, 11481.081513478985, 11576.826347604792, 11582.131340149439, 11590.652280431601, 11603.593874214363, 12126.878731212662, 12127.0, 12598.370081495888, 12604.55884044054, 12730.490780368775, 9672.613095476172, 9734.853977190347, 9816.852747208797, 9938.801223975552, 10118.696439106838, 3255.283837555734, 3286.523454099166, 3312.7846689965318, 3351.782134161296, 3402.625711171769, 47719.522804771856, 47737.0, 47850.52149478495, 47939.520604793855, 48780.0, 9465.90534094664, 9476.147146756824, 9731.56207970643, 10140.645077422403, 10143.492825358702, 16233.107179105027, 16371.508854734377, 16393.59016024609, 16418.097004664618, 16458.83541164597, 6396.072569477493, 6502.089707440962, 6564.80305590833, 6596.604203747695, 6603.966980165068, 3633.3278343506536, 3637.727170462226, 3666.944995825065, 3717.498137751369, 3821.9426708599394, 2794.8602569871423, 2850.6009158717798, 2853.571964205386, 2872.2532141643323, 2877.956830647542, 519.1460048220731, 521.0438844719905, 522.334024119251, 525.8291055407008, 532.1990404441368, 503.62983207342575, 508.47626944247486, 583.6983526735404, 624.1012941364421, 649.3928177154376, 7320.560766354036, 7553.093628764474, 7588.0, 7610.086789585174, 7765.495242809199, 444.5310197741414, 499.6876951905059, 501.32571691075447, 562.9324481062299, 563.8393057978457, 3521.7006554442646, 3717.981410092932, 3761.8495260189834, 3826.770393776382, 3833.6358045985585, 41439.58560414357, 46122.76938615352, 46302.305465418045, 46327.0, 48603.513964860605, 38849.0, 39504.604953950664, 41388.965275868344, 41774.37338439926, 42013.57986420158, 32560.34879302353, 38746.03134921649, 39015.21969560593, 39231.0, 39330.0, 7540.924590754023, 7649.349805266615, 7696.538207707332, 7725.111612164673, 7821.765347039598, 27533.724662753117, 27837.304067398476, 28470.0, 28560.0, 28862.422751544433, 34371.31257374889, 35155.472667910515, 36079.45880811737, 36936.0, 37190.25619487541, 10332.690019299433, 10424.530896109542, 10458.843117353093, 10588.152947764314, 10608.681739547827, 11659.766804664028, 11680.0, 11987.280763154238, 12141.817872731739, 12216.144869859025, 10446.52990615409, 10594.682159535227, 10724.088452481627, 10888.782224355627, 10941.398223097805, 10584.206184536344, 10628.202884783826, 10632.681019569425, 11078.778424431304, 11078.889211107786, 10402.583896644352, 10514.369137851754, 10592.523336450033, 10618.8938110621, 11252.212345135762, 9791.657291994747, 9807.803843923224, 9848.113669769755, 9894.257930655374, 10159.7460063499, 9469.880118635087, 9740.75648108803, 9801.460919649202, 9801.705948821547, 9927.106560409598], "value": 5753.7226358943735, "unit": "score"}], "name": "dromaeo_css", "value": 6360.8399952075915, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 106.0, 112.0, 114.0, 114.0, 102.0, 112.0, 112.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 137.0, 161.0, 177.0, 134.0, 160.0, 161.0, 139.0, 188.0, 132.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 110.0, 103.0, 73.0, 73.0, 73.0, 129.0, 103.0, 73.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 146.0, 93.0, 94.0, 93.0, 136.0, 94.0, 94.0, 148.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 67.0, 66.0, 65.0, 64.0, 82.0, 63.0, 63.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 70.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 146.0, 144.0, 139.0, 135.0, 146.0, 139.0, 169.0, 147.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 171.0, 173.0, 171.0, 188.0, 172.0, 172.0, 171.0, 171.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 75.0, 74.0, 71.0, 72.0, 72.0, 72.0, 77.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1589.8, "alertThreshold": 2.0}]} 17:13:52 INFO - Return code: 0 17:13:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:13:52 ERROR - # TBPL SUCCESS # 17:13:52 INFO - Running post-action listener: _resource_record_post_action 17:13:52 INFO - Running post-run listener: _resource_record_post_run 17:13:53 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 143360; Write bytes: 294612992; Read time: 240; Write time: 220436 17:13:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 17326080; Read time: 16; Write time: 13344 17:13:53 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 139264; Write bytes: 277286912; Read time: 224; Write time: 207092 17:13:53 INFO - Running post-run listener: _upload_blobber_files 17:13:53 INFO - Blob upload gear active. 17:13:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:13:54 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:13:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:13:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:55 INFO - (blobuploader) - INFO - Done attempting. 17:13:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:13:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:13:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:55 INFO - (blobuploader) - INFO - Done attempting. 17:13:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:55 INFO - Return code: 0 17:13:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88b49180526456eb85d59ccb36a75d49b9d26b7adfe3b12bb7b86ca7a69fcb82d308f1c34d0a765f1cf2eafe2fef0eacd8c00ac11b296bf11ad54839f9ab99e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/952530405cc4ea34bf061a2229f26f633205dabffe3917f6b3c9c2f2f62defa870d8b4fe1d23432077fc7c2f2015a7ed41814e80896f3f8bbc5ecc5a632fabe2"} 17:13:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:55 INFO - Contents: 17:13:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88b49180526456eb85d59ccb36a75d49b9d26b7adfe3b12bb7b86ca7a69fcb82d308f1c34d0a765f1cf2eafe2fef0eacd8c00ac11b296bf11ad54839f9ab99e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/952530405cc4ea34bf061a2229f26f633205dabffe3917f6b3c9c2f2f62defa870d8b4fe1d23432077fc7c2f2015a7ed41814e80896f3f8bbc5ecc5a632fabe2"} 17:13:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:55 INFO - Copying logs to upload dir... 17:13:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.689457 ========= master_lag: 36.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-04-14 17:14:31.921085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:14:31.925108) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381 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/88b49180526456eb85d59ccb36a75d49b9d26b7adfe3b12bb7b86ca7a69fcb82d308f1c34d0a765f1cf2eafe2fef0eacd8c00ac11b296bf11ad54839f9ab99e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/952530405cc4ea34bf061a2229f26f633205dabffe3917f6b3c9c2f2f62defa870d8b4fe1d23432077fc7c2f2015a7ed41814e80896f3f8bbc5ecc5a632fabe2"} build_url:https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.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/88b49180526456eb85d59ccb36a75d49b9d26b7adfe3b12bb7b86ca7a69fcb82d308f1c34d0a765f1cf2eafe2fef0eacd8c00ac11b296bf11ad54839f9ab99e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/952530405cc4ea34bf061a2229f26f633205dabffe3917f6b3c9c2f2f62defa870d8b4fe1d23432077fc7c2f2015a7ed41814e80896f3f8bbc5ecc5a632fabe2"}' ========= master_lag: 0.95 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:14:32.888310) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:14:32.888742) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1460677995.704682-1278699381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:14:33.031118) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-14 17:14:33.031454) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-14 17:14:34.043395) ========= ========= Total master_lag: 37.17 =========