builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1469103654.18 results: success (0) buildid: 20160720071819 builduid: 58da0a028d44484fa926789a8ae521c3 revision: 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:54.184106) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:54.184574) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:54.184858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:54.199959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:54.200331) ========= 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=745a4373a2a16df560f216e000000264-1469103653.893423-1995443440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 05:20:54-- 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% 225M=0s 2016-07-21 05:20:54 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104421 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:54.319575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:54.319967) ========= 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=745a4373a2a16df560f216e000000264-1469103653.893423-1995443440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021918 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:54.369856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 05:20:54.370230) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e --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=745a4373a2a16df560f216e000000264-1469103653.893423-1995443440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 05:20:54,924 truncating revision to first 12 chars 2016-07-21 05:20:54,924 Setting DEBUG logging. 2016-07-21 05:20:54,924 attempt 1/10 2016-07-21 05:20:54,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9e887ad7d5eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 05:20:56,079 unpacking tar archive at: mozilla-beta-9e887ad7d5eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.488028 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 05:20:55.871924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:55.872252) ========= script_repo_revision: 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:55.872667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:55.872937) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 05:20:55.882859) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-07-21 05:20:55.883163) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=745a4373a2a16df560f216e000000264-1469103653.893423-1995443440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:56 INFO - MultiFileLogger online at 20160721 05:20:56 in /builds/slave/test 05:20:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:20:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:56 INFO - {'append_to_log': False, 05:20:56 INFO - 'base_work_dir': '/builds/slave/test', 05:20:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:20:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:56 INFO - 'branch': 'Mozilla-Beta', 05:20:56 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:56 INFO - 'config_files': ('talos/linux_config.py',), 05:20:56 INFO - 'default_actions': ('clobber', 05:20:56 INFO - 'read-buildbot-config', 05:20:56 INFO - 'download-and-extract', 05:20:56 INFO - 'populate-webroot', 05:20:56 INFO - 'create-virtualenv', 05:20:56 INFO - 'install', 05:20:56 INFO - 'run-tests'), 05:20:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:56 INFO - 'download_minidump_stackwalk': True, 05:20:56 INFO - 'download_symbols': 'ondemand', 05:20:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:56 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:56 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:56 INFO - 'installer_path': 'installer.exe', 05:20:56 INFO - 'log_level': 'info', 05:20:56 INFO - 'log_name': 'talos', 05:20:56 INFO - 'log_to_console': True, 05:20:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:56 INFO - 'opt_config_files': (), 05:20:56 INFO - 'pip_index': False, 05:20:56 INFO - 'sps_profile': False, 05:20:56 INFO - 'sps_profile_interval': 0, 05:20:56 INFO - 'suite': 'dromaeojs-e10s', 05:20:56 INFO - 'system_bits': '32', 05:20:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:56 INFO - 'title': 'talos-linux64-ix-032', 05:20:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:56 INFO - 'use_talos_json': True, 05:20:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:56 INFO - 'work_dir': 'build'} 05:20:56 INFO - ##### 05:20:56 INFO - ##### Running clobber step. 05:20:56 INFO - ##### 05:20:56 INFO - Running pre-action listener: _resource_record_pre_action 05:20:56 INFO - Running main action method: clobber 05:20:56 INFO - rmtree: /builds/slave/test/build 05:20:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:20:57 INFO - Running post-action listener: _resource_record_post_action 05:20:57 INFO - ##### 05:20:57 INFO - ##### Running read-buildbot-config step. 05:20:57 INFO - ##### 05:20:57 INFO - Running pre-action listener: _resource_record_pre_action 05:20:57 INFO - Running main action method: read_buildbot_config 05:20:57 INFO - Using buildbot properties: 05:20:57 INFO - { 05:20:57 INFO - "project": "", 05:20:57 INFO - "product": "firefox", 05:20:57 INFO - "script_repo_revision": "production", 05:20:57 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:20:57 INFO - "repository": "", 05:20:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 05:20:57 INFO - "buildid": "20160720071819", 05:20:57 INFO - "pgo_build": "True", 05:20:57 INFO - "basedir": "/builds/slave/test", 05:20:57 INFO - "buildnumber": 181, 05:20:57 INFO - "slavename": "talos-linux64-ix-032", 05:20:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:20:57 INFO - "platform": "ubuntu64_hw", 05:20:57 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:20:57 INFO - "branch": "mozilla-beta", 05:20:57 INFO - "repo_path": "releases/mozilla-beta", 05:20:57 INFO - "revision": "9e887ad7d5ebd5369782230a86c3a51f84e9ab0e", 05:20:57 INFO - "stage_platform": "linux64-pgo", 05:20:57 INFO - "builduid": "58da0a028d44484fa926789a8ae521c3", 05:20:57 INFO - "slavebuilddir": "test" 05:20:57 INFO - } 05:20:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 05:20:57 INFO - Running post-action listener: _resource_record_post_action 05:20:57 INFO - ##### 05:20:57 INFO - ##### Running download-and-extract step. 05:20:57 INFO - ##### 05:20:57 INFO - Running pre-action listener: _resource_record_pre_action 05:20:57 INFO - Running main action method: download_and_extract 05:20:57 INFO - mkdir: /builds/slave/test/build/tests 05:20:57 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')]} 05:20:57 INFO - https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:20:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:20:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:20:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:20:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:20:57 INFO - Downloaded 1327 bytes. 05:20:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:20:57 INFO - Using the following test package requirements: 05:20:57 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:20:57 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:20:57 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:57 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:20:57 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 05:20:57 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:20:57 INFO - u'jsshell-linux-x86_64.zip'], 05:20:57 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:20:57 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:57 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:20:57 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:20:57 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 05:20:57 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:20:57 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 05:20:57 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:20:57 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:57 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:20:57 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:57 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20:57 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')]} 05:20:57 INFO - https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:20:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:20:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:20:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:58 INFO - Downloaded 24199367 bytes. 05:20:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:59 INFO - Return code: 0 05:20:59 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:59 INFO - https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:20:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:20:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:20:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:00 INFO - Downloaded 24199367 bytes. 05:21:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:21:02 INFO - Return code: 0 05:21:02 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')]} 05:21:02 INFO - https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:21:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:21:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:21:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:21:03 INFO - Downloaded 10840145 bytes. 05:21:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:21:03 INFO - Return code: 0 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:21:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:21:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:21:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:21:04 INFO - Downloaded 56030694 bytes. 05:21:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:21:04 INFO - mkdir: /builds/slave/test/properties 05:21:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:04 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:04 INFO - Contents: 05:21:04 INFO - build_url:https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:21:05 INFO - Running post-action listener: _resource_record_post_action 05:21:05 INFO - Running post-action listener: set_extra_try_arguments 05:21:05 INFO - ##### 05:21:05 INFO - ##### Running populate-webroot step. 05:21:05 INFO - ##### 05:21:05 INFO - Running pre-action listener: _resource_record_pre_action 05:21:05 INFO - Running main action method: populate_webroot 05:21:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:05 INFO - '--tppagecycles', 05:21:05 INFO - '7'], 05:21:05 INFO - 'tests': ['tsvgm']}}, 05:21:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:21:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:21:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:21:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:21:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:05 INFO - 'talos_options': ['--disable-e10s'], 05:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:05 INFO - 'talos_options': ['--disable-e10s'], 05:21:05 INFO - 'tests': ['damp', 'tps']}, 05:21:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:05 INFO - 'tests': ['damp', 'tps']}, 05:21:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:21:05 INFO - 'tests': ['dromaeo_dom']}, 05:21:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:21:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:21:05 INFO - 'tests': ['a11yr', 05:21:05 INFO - 'ts_paint', 05:21:05 INFO - 'tpaint', 05:21:05 INFO - 'sessionrestore', 05:21:05 INFO - 'sessionrestore_no_auto_restore', 05:21:05 INFO - 'tabpaint']}, 05:21:05 INFO - 'other-e10s': {'tests': ['a11yr', 05:21:05 INFO - 'ts_paint', 05:21:05 INFO - 'tpaint', 05:21:05 INFO - 'sessionrestore', 05:21:05 INFO - 'sessionrestore_no_auto_restore', 05:21:05 INFO - 'tabpaint']}, 05:21:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:21:05 INFO - 'ts_paint', 05:21:05 INFO - 'tpaint', 05:21:05 INFO - 'sessionrestore', 05:21:05 INFO - 'sessionrestore_no_auto_restore', 05:21:05 INFO - 'tabpaint']}, 05:21:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:21:05 INFO - 'ts_paint', 05:21:05 INFO - 'tpaint', 05:21:05 INFO - 'sessionrestore', 05:21:05 INFO - 'sessionrestore_no_auto_restore', 05:21:05 INFO - 'tabpaint']}, 05:21:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:21:05 INFO - 'tests': ['a11yr', 05:21:05 INFO - 'ts_paint', 05:21:05 INFO - 'tpaint', 05:21:05 INFO - 'sessionrestore', 05:21:05 INFO - 'sessionrestore_no_auto_restore', 05:21:05 INFO - 'tabpaint']}, 05:21:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:21:05 INFO - 'tests': ['a11yr', 05:21:05 INFO - 'ts_paint', 05:21:05 INFO - 'tpaint', 05:21:05 INFO - 'sessionrestore', 05:21:05 INFO - 'sessionrestore_no_auto_restore', 05:21:05 INFO - 'tabpaint']}, 05:21:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:21:05 INFO - 'tests': ['tsvgx', 05:21:05 INFO - 'tsvgr_opacity', 05:21:05 INFO - 'tart', 05:21:05 INFO - 'tscrollx', 05:21:05 INFO - 'cart']}, 05:21:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:21:05 INFO - 'tsvgr_opacity', 05:21:05 INFO - 'tart', 05:21:05 INFO - 'tscrollx', 05:21:05 INFO - 'cart']}, 05:21:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:05 INFO - 'talos_options': ['--disable-e10s'], 05:21:05 INFO - 'tests': ['tp5o']}, 05:21:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:05 INFO - 'tests': ['tp5o']}, 05:21:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:05 INFO - 'talos_options': ['--disable-e10s', 05:21:05 INFO - '--xperf_path', 05:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:05 INFO - 'tests': ['tp5n']}, 05:21:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:05 INFO - 'talos_options': ['--xperf_path', 05:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:05 INFO - 'tests': ['tp5n']}}, 05:21:05 INFO - 'talos.zip': {'path': '', 05:21:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:05 INFO - Running post-action listener: _resource_record_post_action 05:21:05 INFO - ##### 05:21:05 INFO - ##### Running create-virtualenv step. 05:21:05 INFO - ##### 05:21:05 INFO - Running pre-action listener: _resource_record_pre_action 05:21:05 INFO - Running main action method: create_virtualenv 05:21:05 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:05 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 05:21:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:05 INFO - Using real prefix '/usr' 05:21:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:06 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:08 INFO - Installing pip.................done. 05:21:08 INFO - Return code: 0 05:21:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:08 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 0x7fb52e997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973410>, '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 0x2974310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29747a0>, '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': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', '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 05:21:08 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 05:21:08 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 05:21:08 INFO - Using env: {'DISPLAY': ':0', 05:21:08 INFO - 'HOME': '/home/cltbld', 05:21:08 INFO - 'LANG': 'en_US.UTF-8', 05:21:08 INFO - 'LANGUAGE': 'en_US:en', 05:21:08 INFO - 'LOGNAME': 'cltbld', 05:21:08 INFO - 'MAIL': '/var/mail/cltbld', 05:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:08 INFO - 'MOZ_NO_REMOTE': '1', 05:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:08 INFO - 'NO_EM_RESTART': '1', 05:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:08 INFO - 'PWD': '/builds/slave/test', 05:21:08 INFO - 'SHELL': '/bin/bash', 05:21:08 INFO - 'SHLVL': '1', 05:21:08 INFO - 'TERM': 'linux', 05:21:08 INFO - 'TMOUT': '86400', 05:21:08 INFO - 'USER': 'cltbld', 05:21:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', 05:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:08 INFO - '_': '/tools/buildbot/bin/python'} 05:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:08 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 05:21:08 INFO - Cleaning up... 05:21:08 INFO - Return code: 0 05:21:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:08 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 0x7fb52e997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973410>, '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 0x2974310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29747a0>, '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': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', '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 05:21:08 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 05:21:08 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 05:21:08 INFO - Using env: {'DISPLAY': ':0', 05:21:08 INFO - 'HOME': '/home/cltbld', 05:21:08 INFO - 'LANG': 'en_US.UTF-8', 05:21:08 INFO - 'LANGUAGE': 'en_US:en', 05:21:08 INFO - 'LOGNAME': 'cltbld', 05:21:08 INFO - 'MAIL': '/var/mail/cltbld', 05:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:08 INFO - 'MOZ_NO_REMOTE': '1', 05:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:08 INFO - 'NO_EM_RESTART': '1', 05:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:08 INFO - 'PWD': '/builds/slave/test', 05:21:08 INFO - 'SHELL': '/bin/bash', 05:21:08 INFO - 'SHLVL': '1', 05:21:08 INFO - 'TERM': 'linux', 05:21:08 INFO - 'TMOUT': '86400', 05:21:08 INFO - 'USER': 'cltbld', 05:21:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', 05:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:08 INFO - '_': '/tools/buildbot/bin/python'} 05:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:08 INFO - Downloading/unpacking psutil>=0.7.1 05:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:10 INFO - Installing collected packages: psutil 05:21:10 INFO - Running setup.py install for psutil 05:21:10 INFO - building 'psutil._psutil_linux' extension 05:21:10 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 05:21:10 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 05:21:10 INFO - building 'psutil._psutil_posix' extension 05:21:10 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 05:21:11 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 05:21:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:11 INFO - Successfully installed psutil 05:21:11 INFO - Cleaning up... 05:21:11 INFO - Return code: 0 05:21:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb52e997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973410>, '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 0x2974310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29747a0>, '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': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', '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 05:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:21:11 INFO - Using env: {'DISPLAY': ':0', 05:21:11 INFO - 'HOME': '/home/cltbld', 05:21:11 INFO - 'LANG': 'en_US.UTF-8', 05:21:11 INFO - 'LANGUAGE': 'en_US:en', 05:21:11 INFO - 'LOGNAME': 'cltbld', 05:21:11 INFO - 'MAIL': '/var/mail/cltbld', 05:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:11 INFO - 'MOZ_NO_REMOTE': '1', 05:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:11 INFO - 'NO_EM_RESTART': '1', 05:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:11 INFO - 'PWD': '/builds/slave/test', 05:21:11 INFO - 'SHELL': '/bin/bash', 05:21:11 INFO - 'SHLVL': '1', 05:21:11 INFO - 'TERM': 'linux', 05:21:11 INFO - 'TMOUT': '86400', 05:21:11 INFO - 'USER': 'cltbld', 05:21:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', 05:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:11 INFO - '_': '/tools/buildbot/bin/python'} 05:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:21:13 INFO - Installing collected packages: mozsystemmonitor 05:21:13 INFO - Running setup.py install for mozsystemmonitor 05:21:13 INFO - Successfully installed mozsystemmonitor 05:21:13 INFO - Cleaning up... 05:21:13 INFO - Return code: 0 05:21:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb52e997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973410>, '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 0x2974310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29747a0>, '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': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', '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 05:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:21:13 INFO - Using env: {'DISPLAY': ':0', 05:21:13 INFO - 'HOME': '/home/cltbld', 05:21:13 INFO - 'LANG': 'en_US.UTF-8', 05:21:13 INFO - 'LANGUAGE': 'en_US:en', 05:21:13 INFO - 'LOGNAME': 'cltbld', 05:21:13 INFO - 'MAIL': '/var/mail/cltbld', 05:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:13 INFO - 'MOZ_NO_REMOTE': '1', 05:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:13 INFO - 'NO_EM_RESTART': '1', 05:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:13 INFO - 'PWD': '/builds/slave/test', 05:21:13 INFO - 'SHELL': '/bin/bash', 05:21:13 INFO - 'SHLVL': '1', 05:21:13 INFO - 'TERM': 'linux', 05:21:13 INFO - 'TMOUT': '86400', 05:21:13 INFO - 'USER': 'cltbld', 05:21:13 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', 05:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:13 INFO - '_': '/tools/buildbot/bin/python'} 05:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:13 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:15 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:15 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 05:21:15 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 05:21:15 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 05:21:15 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 05:21:15 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 05:21:15 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 05:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:16 INFO - Downloading docopt-0.6.1.tar.gz 05:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:16 INFO - Running setup.py install for blobuploader 05:21:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:16 INFO - Running setup.py install for requests 05:21:16 INFO - Running setup.py install for docopt 05:21:16 INFO - Successfully installed blobuploader requests docopt 05:21:16 INFO - Cleaning up... 05:21:17 INFO - Return code: 0 05:21:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:17 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 0x7fb52e997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973410>, '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 0x2974310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29747a0>, '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': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', '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 05:21:17 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 05:21:17 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 05:21:17 INFO - Using env: {'DISPLAY': ':0', 05:21:17 INFO - 'HOME': '/home/cltbld', 05:21:17 INFO - 'LANG': 'en_US.UTF-8', 05:21:17 INFO - 'LANGUAGE': 'en_US:en', 05:21:17 INFO - 'LOGNAME': 'cltbld', 05:21:17 INFO - 'MAIL': '/var/mail/cltbld', 05:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:17 INFO - 'MOZ_NO_REMOTE': '1', 05:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:17 INFO - 'NO_EM_RESTART': '1', 05:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:17 INFO - 'PWD': '/builds/slave/test', 05:21:17 INFO - 'SHELL': '/bin/bash', 05:21:17 INFO - 'SHLVL': '1', 05:21:17 INFO - 'TERM': 'linux', 05:21:17 INFO - 'TMOUT': '86400', 05:21:17 INFO - 'USER': 'cltbld', 05:21:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', 05:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:17 INFO - '_': '/tools/buildbot/bin/python'} 05:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:17 INFO - Running setup.py (path:/tmp/pip-zZ35B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:17 INFO - Running setup.py (path:/tmp/pip-bW63hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:17 INFO - Running setup.py (path:/tmp/pip-k7gNlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:17 INFO - Running setup.py (path:/tmp/pip-EApmdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:17 INFO - Running setup.py (path:/tmp/pip-GDfGhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:17 INFO - Running setup.py (path:/tmp/pip-VARJBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:17 INFO - Running setup.py (path:/tmp/pip-8r3C1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:17 INFO - Running setup.py (path:/tmp/pip-l3ijNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:17 INFO - Running setup.py (path:/tmp/pip-khTnM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:17 INFO - Running setup.py (path:/tmp/pip-BdAPOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:17 INFO - Running setup.py (path:/tmp/pip-C951N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:18 INFO - Running setup.py (path:/tmp/pip-nKf0RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:18 INFO - Running setup.py (path:/tmp/pip-q4D921-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:18 INFO - Running setup.py (path:/tmp/pip-u7O7Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:18 INFO - Running setup.py (path:/tmp/pip-pysYY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:18 INFO - Running setup.py (path:/tmp/pip-jDHSev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:18 INFO - Running setup.py (path:/tmp/pip-kXAHxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:18 INFO - Running setup.py install for manifestparser 05:21:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:18 INFO - Running setup.py install for mozcrash 05:21:18 INFO - Running setup.py install for mozdebug 05:21:18 INFO - Running setup.py install for mozdevice 05:21:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:18 INFO - Running setup.py install for mozfile 05:21:18 INFO - Running setup.py install for mozhttpd 05:21:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Running setup.py install for mozinfo 05:21:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Running setup.py install for mozInstall 05:21:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Running setup.py install for mozleak 05:21:19 INFO - Running setup.py install for mozlog 05:21:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Running setup.py install for moznetwork 05:21:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Running setup.py install for mozprocess 05:21:19 INFO - Running setup.py install for mozprofile 05:21:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Running setup.py install for mozrunner 05:21:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:19 INFO - Running setup.py install for mozscreenshot 05:21:20 INFO - Running setup.py install for moztest 05:21:20 INFO - Running setup.py install for mozversion 05:21:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:20 INFO - Cleaning up... 05:21:20 INFO - Return code: 0 05:21:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:20 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 0x7fb52e997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973410>, '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 0x2974310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29747a0>, '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': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', '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 05:21:20 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 05:21:20 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 05:21:20 INFO - Using env: {'DISPLAY': ':0', 05:21:20 INFO - 'HOME': '/home/cltbld', 05:21:20 INFO - 'LANG': 'en_US.UTF-8', 05:21:20 INFO - 'LANGUAGE': 'en_US:en', 05:21:20 INFO - 'LOGNAME': 'cltbld', 05:21:20 INFO - 'MAIL': '/var/mail/cltbld', 05:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:20 INFO - 'MOZ_NO_REMOTE': '1', 05:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:20 INFO - 'NO_EM_RESTART': '1', 05:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:20 INFO - 'PWD': '/builds/slave/test', 05:21:20 INFO - 'SHELL': '/bin/bash', 05:21:20 INFO - 'SHLVL': '1', 05:21:20 INFO - 'TERM': 'linux', 05:21:20 INFO - 'TMOUT': '86400', 05:21:20 INFO - 'USER': 'cltbld', 05:21:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', 05:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:20 INFO - '_': '/tools/buildbot/bin/python'} 05:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:20 INFO - Running setup.py (path:/tmp/pip-PZxgPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:20 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)) 05:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:20 INFO - Running setup.py (path:/tmp/pip-N1qHE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:20 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)) 05:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:20 INFO - Running setup.py (path:/tmp/pip-KeHIMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:20 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)) 05:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:20 INFO - Running setup.py (path:/tmp/pip-2vt8Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:20 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)) 05:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:20 INFO - Running setup.py (path:/tmp/pip-xxdGXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:20 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)) 05:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:20 INFO - Running setup.py (path:/tmp/pip-rBlsis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:20 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)) 05:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:20 INFO - Running setup.py (path:/tmp/pip-cU4DZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:20 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)) 05:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:20 INFO - Running setup.py (path:/tmp/pip-VSn0us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:21 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)) 05:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:21 INFO - Running setup.py (path:/tmp/pip-5go2Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:21 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)) 05:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:21 INFO - Running setup.py (path:/tmp/pip-ChDrNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:21 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)) 05:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:21 INFO - Running setup.py (path:/tmp/pip-Cr_FE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:21 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)) 05:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:21 INFO - Running setup.py (path:/tmp/pip-PJGZ0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:21 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)) 05:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:21 INFO - Running setup.py (path:/tmp/pip-6V8KUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:21 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)) 05:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:21 INFO - Running setup.py (path:/tmp/pip-5pXGB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:21 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)) 05:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:21 INFO - Running setup.py (path:/tmp/pip-qqtIOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:21 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)) 05:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:21 INFO - Running setup.py (path:/tmp/pip-ktqIUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:21 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)) 05:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:21 INFO - Running setup.py (path:/tmp/pip-QLcg0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:21 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)) 05:21:21 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)) 05:21:21 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)) 05:21:21 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)) 05:21:21 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)) 05:21:21 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)) 05:21:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:23 INFO - Downloading blessings-1.6.tar.gz 05:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:23 INFO - Installing collected packages: blessings 05:21:23 INFO - Running setup.py install for blessings 05:21:23 INFO - Successfully installed blessings 05:21:23 INFO - Cleaning up... 05:21:23 INFO - Return code: 0 05:21:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:24 INFO - Reading from file tmpfile_stdout 05:21:24 INFO - Current package versions: 05:21:24 INFO - argparse == 1.2.1 05:21:24 INFO - blessings == 1.6 05:21:24 INFO - blobuploader == 1.2.4 05:21:24 INFO - docopt == 0.6.1 05:21:24 INFO - manifestparser == 1.1 05:21:24 INFO - mozInstall == 1.12 05:21:24 INFO - mozcrash == 0.17 05:21:24 INFO - mozdebug == 0.1 05:21:24 INFO - mozdevice == 0.48 05:21:24 INFO - mozfile == 1.2 05:21:24 INFO - mozhttpd == 0.7 05:21:24 INFO - mozinfo == 0.9 05:21:24 INFO - mozleak == 0.1 05:21:24 INFO - mozlog == 3.1 05:21:24 INFO - moznetwork == 0.27 05:21:24 INFO - mozprocess == 0.22 05:21:24 INFO - mozprofile == 0.28 05:21:24 INFO - mozrunner == 6.11 05:21:24 INFO - mozscreenshot == 0.1 05:21:24 INFO - mozsystemmonitor == 0.0 05:21:24 INFO - moztest == 0.7 05:21:24 INFO - mozversion == 1.4 05:21:24 INFO - psutil == 3.1.1 05:21:24 INFO - requests == 1.2.3 05:21:24 INFO - wsgiref == 0.1.2 05:21:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:24 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 0x7fb52e997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973410>, '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 0x2974310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29747a0>, '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': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', '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 05:21:24 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 05:21:24 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 05:21:24 INFO - Using env: {'DISPLAY': ':0', 05:21:24 INFO - 'HOME': '/home/cltbld', 05:21:24 INFO - 'LANG': 'en_US.UTF-8', 05:21:24 INFO - 'LANGUAGE': 'en_US:en', 05:21:24 INFO - 'LOGNAME': 'cltbld', 05:21:24 INFO - 'MAIL': '/var/mail/cltbld', 05:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:24 INFO - 'MOZ_NO_REMOTE': '1', 05:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:24 INFO - 'NO_EM_RESTART': '1', 05:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:24 INFO - 'PWD': '/builds/slave/test', 05:21:24 INFO - 'SHELL': '/bin/bash', 05:21:24 INFO - 'SHLVL': '1', 05:21:24 INFO - 'TERM': 'linux', 05:21:24 INFO - 'TMOUT': '86400', 05:21:24 INFO - 'USER': 'cltbld', 05:21:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', 05:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:24 INFO - '_': '/tools/buildbot/bin/python'} 05:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:24 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)) 05:21:24 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)) 05:21:24 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)) 05:21:24 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)) 05:21:24 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)) 05:21:24 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)) 05:21:24 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)) 05:21:24 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)) 05:21:24 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)) 05:21:24 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)) 05:21:24 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)) 05:21:24 INFO - Cleaning up... 05:21:24 INFO - Return code: 0 05:21:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:24 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 0x7fb52e997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973410>, '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 0x2974310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29747a0>, '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': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', '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 05:21:24 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 05:21:24 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 05:21:24 INFO - Using env: {'DISPLAY': ':0', 05:21:24 INFO - 'HOME': '/home/cltbld', 05:21:24 INFO - 'LANG': 'en_US.UTF-8', 05:21:24 INFO - 'LANGUAGE': 'en_US:en', 05:21:24 INFO - 'LOGNAME': 'cltbld', 05:21:24 INFO - 'MAIL': '/var/mail/cltbld', 05:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:24 INFO - 'MOZ_NO_REMOTE': '1', 05:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:24 INFO - 'NO_EM_RESTART': '1', 05:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:24 INFO - 'PWD': '/builds/slave/test', 05:21:24 INFO - 'SHELL': '/bin/bash', 05:21:24 INFO - 'SHLVL': '1', 05:21:24 INFO - 'TERM': 'linux', 05:21:24 INFO - 'TMOUT': '86400', 05:21:24 INFO - 'USER': 'cltbld', 05:21:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', 05:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:24 INFO - '_': '/tools/buildbot/bin/python'} 05:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:24 INFO - Downloading/unpacking jsonschema 05:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:26 INFO - Downloading/unpacking functools32 (from jsonschema) 05:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:26 INFO - warning: no files found matching '*.txt' 05:21:26 INFO - no previously-included directories found matching 'build' 05:21:26 INFO - no previously-included directories found matching 'dist' 05:21:26 INFO - no previously-included directories found matching '.git*' 05:21:26 INFO - Installing collected packages: jsonschema, functools32 05:21:26 INFO - Running setup.py install for functools32 05:21:26 INFO - warning: no files found matching '*.txt' 05:21:26 INFO - no previously-included directories found matching 'build' 05:21:26 INFO - no previously-included directories found matching 'dist' 05:21:26 INFO - no previously-included directories found matching '.git*' 05:21:26 INFO - Successfully installed jsonschema functools32 05:21:26 INFO - Cleaning up... 05:21:26 INFO - Return code: 0 05:21:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:21:26 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')]} 05:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:26 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')]} 05:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:26 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 0x7fb52e997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2973410>, '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 0x2974310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29747a0>, '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': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', '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 05:21:26 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 05:21:26 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 05:21:26 INFO - Using env: {'DISPLAY': ':0', 05:21:26 INFO - 'HOME': '/home/cltbld', 05:21:26 INFO - 'LANG': 'en_US.UTF-8', 05:21:26 INFO - 'LANGUAGE': 'en_US:en', 05:21:26 INFO - 'LOGNAME': 'cltbld', 05:21:26 INFO - 'MAIL': '/var/mail/cltbld', 05:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:26 INFO - 'MOZ_NO_REMOTE': '1', 05:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:26 INFO - 'NO_EM_RESTART': '1', 05:21:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:26 INFO - 'PWD': '/builds/slave/test', 05:21:26 INFO - 'SHELL': '/bin/bash', 05:21:26 INFO - 'SHLVL': '1', 05:21:26 INFO - 'TERM': 'linux', 05:21:26 INFO - 'TMOUT': '86400', 05:21:26 INFO - 'USER': 'cltbld', 05:21:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', 05:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:26 INFO - '_': '/tools/buildbot/bin/python'} 05:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:27 INFO - Downloading/unpacking flake8 05:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:21:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:21:28 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 05:21:28 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 05:21:28 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 05:21:28 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 05:21:28 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 05:21:28 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 05:21:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:21:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:21:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:29 INFO - no previously-included directories found matching 'docs/_build' 05:21:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:21:29 INFO - Running setup.py install for pep8 05:21:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:29 INFO - no previously-included directories found matching 'docs/_build' 05:21:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:21:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:21:29 INFO - Cleaning up... 05:21:29 INFO - Return code: 0 05:21:29 INFO - Running post-action listener: _resource_record_post_action 05:21:29 INFO - Running post-action listener: _start_resource_monitoring 05:21:29 INFO - Starting resource monitoring. 05:21:29 INFO - ##### 05:21:29 INFO - ##### Running install step. 05:21:29 INFO - ##### 05:21:29 INFO - Running pre-action listener: _resource_record_pre_action 05:21:29 INFO - Running main action method: install 05:21:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:30 INFO - Reading from file tmpfile_stdout 05:21:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:30 INFO - Reading from file tmpfile_stdout 05:21:30 INFO - Output received: 05:21:30 INFO - Usage: mozinstall [options] installer 05:21:30 INFO - Options: 05:21:30 INFO - -h, --help show this help message and exit 05:21:30 INFO - -d DEST, --destination=DEST 05:21:30 INFO - Directory to install application into. [default: 05:21:30 INFO - "/builds/slave/test"] 05:21:30 INFO - --app=APP Application being installed. [default: firefox] 05:21:30 INFO - mkdir: /builds/slave/test/build/application 05:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:21:43 INFO - Reading from file tmpfile_stdout 05:21:43 INFO - Output received: 05:21:43 INFO - /builds/slave/test/build/application/firefox/firefox 05:21:43 INFO - Running post-action listener: _resource_record_post_action 05:21:43 INFO - ##### 05:21:43 INFO - ##### Running run-tests step. 05:21:43 INFO - ##### 05:21:43 INFO - Running pre-action listener: _resource_record_pre_action 05:21:43 INFO - Running main action method: run_tests 05:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:21:43 INFO - Python 2.7.3 05:21:43 INFO - Return code: 0 05:21:43 INFO - grabbing minidump binary from tooltool 05:21: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')]} 05:21:43 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 0x2973410>, '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 0x2974310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29747a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:21:43 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 05:21:43 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 05:21:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:21:44 INFO - Return code: 0 05:21:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:21:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:21:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:21:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:21:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:21:44 INFO - Return code: 0 05:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:21:44 INFO - Using env: {'DISPLAY': ':0', 05:21:44 INFO - 'HOME': '/home/cltbld', 05:21:44 INFO - 'LANG': 'en_US.UTF-8', 05:21:44 INFO - 'LANGUAGE': 'en_US:en', 05:21:44 INFO - 'LOGNAME': 'cltbld', 05:21:44 INFO - 'MAIL': '/var/mail/cltbld', 05:21:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:21:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:44 INFO - 'MOZ_NO_REMOTE': '1', 05:21:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:44 INFO - 'NO_EM_RESTART': '1', 05:21:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:44 INFO - 'PWD': '/builds/slave/test', 05:21:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:21:44 INFO - 'SHELL': '/bin/bash', 05:21:44 INFO - 'SHLVL': '1', 05:21:44 INFO - 'TERM': 'linux', 05:21:44 INFO - 'TMOUT': '86400', 05:21:44 INFO - 'USER': 'cltbld', 05:21:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469103653.893423-1995443440', 05:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:44 INFO - '_': '/tools/buildbot/bin/python'} 05:21:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:21:45 INFO - mozversion application_buildid: 20160720071819 05:21:45 INFO - mozversion application_changeset: 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e 05:21:45 INFO - mozversion application_display_name: Firefox 05:21:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:21:45 INFO - mozversion application_name: Firefox 05:21:45 INFO - mozversion application_remotingname: firefox 05:21:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:21:45 INFO - mozversion application_vendor: Mozilla 05:21:45 INFO - mozversion application_version: 48.0 05:21:45 INFO - mozversion platform_buildid: 20160720071819 05:21:45 INFO - mozversion platform_changeset: 9e887ad7d5ebd5369782230a86c3a51f84e9ab0e 05:21:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:21:45 INFO - mozversion platform_version: 48.0 05:21:45 INFO - using testdate: 1469103705 05:21:45 INFO - actual date: 1469103705 05:21:45 INFO - starting webserver on 'localhost:54531' 05:21:45 INFO - SUITE-START | Running 2 tests 05:21:45 INFO - TEST-START | dromaeo_css 05:21:45 INFO - operating with platform_type : linux_ 05:21:45 INFO - Initialising browser for dromaeo_css test... 05:21:45 INFO - TEST-INFO | started process 19311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPSEN5/profile http://localhost:54531/getInfo.html) 05:21:49 INFO - PROCESS | 19311 | 05:21:49 INFO - PROCESS | 19311 | (process:19390): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:21:50 INFO - PROCESS | 19311 | __metrics Screen width/height:1600/1200 05:21:50 INFO - PROCESS | 19311 | colorDepth:24 05:21:50 INFO - PROCESS | 19311 | Browser inner width/height: 1024/697 05:21:50 INFO - PROCESS | 19311 | __metrics 05:21:50 ERROR - PROCESS | 19311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:21:51 INFO - TEST-INFO | 19311: exit 0 05:21:51 INFO - Browser initialized. 05:21:51 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:51 INFO - TEST-INFO | started process 19440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPSEN5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:53 INFO - PROCESS | 19440 | 05:21:53 INFO - PROCESS | 19440 | (process:19506): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:22:03 INFO - PROCESS | 19440 | RSS: Main: 151052288 05:22:03 INFO - PROCESS | 19440 | 05:22:53 INFO - PROCESS | 19440 | 1469103773068 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] 05:25:00 INFO - PROCESS | 19440 | Cycle 1(1): loaded http://localhost:54531/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54531/tests/dromaeo/cssquery-ext.html) 05:25:01 INFO - PROCESS | 19440 | RSS: Main: 154808320 05:25:01 INFO - PROCESS | 19440 | 05:28:03 INFO - PROCESS | 19440 | Cycle 1(1): loaded http://localhost:54531/tests/dromaeo/cssquery-ext.html (next: http://localhost:54531/tests/dromaeo/cssquery-jquery.html) 05:28:04 INFO - PROCESS | 19440 | RSS: Main: 152604672 05:28:04 INFO - PROCESS | 19440 | 05:31:05 INFO - PROCESS | 19440 | Cycle 1(1): loaded http://localhost:54531/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54531/tests/dromaeo/cssquery-mootools.html) 05:31:06 INFO - PROCESS | 19440 | RSS: Main: 152342528 05:31:06 INFO - PROCESS | 19440 | 05:34:08 INFO - PROCESS | 19440 | Cycle 1(1): loaded http://localhost:54531/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54531/tests/dromaeo/cssquery-prototype.html) 05:34:08 INFO - PROCESS | 19440 | RSS: Main: 153554944 05:34:08 INFO - PROCESS | 19440 | 05:37:11 INFO - PROCESS | 19440 | Cycle 1(1): loaded http://localhost:54531/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54531/tests/dromaeo/cssquery-yui.html) 05:37:11 INFO - PROCESS | 19440 | RSS: Main: 152268800 05:37:11 INFO - PROCESS | 19440 | 05:40:13 INFO - PROCESS | 19440 | Cycle 1(1): loaded http://localhost:54531/tests/dromaeo/cssquery-yui.html (next: http://localhost:54531/tests/dromaeo/cssquery-dojo.html) 05:40:14 INFO - PROCESS | 19440 | RSS: Main: 156037120 05:40:14 INFO - PROCESS | 19440 | 05:40:14 INFO - PROCESS | 19440 | __start_tp_report 05:40:14 INFO - PROCESS | 19440 | _x_x_mozilla_page_load 05:40:14 INFO - PROCESS | 19440 | _x_x_mozilla_page_load_details 05:40:14 INFO - PROCESS | 19440 | |i|pagename|runs| 05:40:14 INFO - PROCESS | 19440 | |0;dojo.html;3349.0287816533205;3423.5720534933134;3426.7087297579706;3430.7255419566436;3440.707539859111;5655.151727240911;5667.4615911488445;5686.147077938312;5712.257406537149;5714.085746280596;5657.9717101414535;5671.574631902603;5704.914426283609;5708.543316534678;5712.685802280873;5077.365329333824;5146.305248791421;5202.843914682547;5235.973820130913;5268.499492548221;5128.974355128219;5205.115130427836;5318.361796584396;5319.521243088121;5340.62615616907;5152.381714194302;5212.270282160501;5240.423553409122;5286.577073834103;5317.813876514323;5205.141151709982;5222.477752224785;5227.137522308814;5227.320448341691;5232.424433312332;5054.393472783253;5136.512031357015;5181;5202.219667049935;5239.528442440199;5467.0705979983495;5567.164925261202;5611.719414029323;5621.494065534122;5664.688442135681;6028.39716028398;6062.9090563641585;6064.06007068905;6065.181200537959;6074.3621919698235;6090.056041313604;6115.847103822395;6117.265928088614;6123.938760612381;6124.326324104345;5658.179563963202;5683.090705487102;5723.484886360247;5735.340435849889;5739.483446489836;6209;6213.285472170668;6215.9378406216265;6215.96892015537;6220.284667263232;5978.372270911492;5989;5998.580099393001;6032.517398608101;6090.025595904723;6028.457438830438;6046.3651316612;6049.909251361233;6050.062240352752;6081.452669259788;6013.939860601426;6019.638821670714;6022.608530445507;6022.728977196037;6029.698515074228;5943.821685349447;5956.6723830188885;6054.455099041019;6108.267007959073;6139.723712432951;4574.8507767580495;4583.037562111994;4629.768511574408;4632;4665.370175026328;4164.416981622575;4169.207850508455;4179.414881916534;4187.24629566681;4228.133232687292;5880.558958078162;5880.941190588125;5914.497267732291;5920.674362909996;5959.374265702126;5927.673977931255;6034.2155519782145;6064.787732429344;6122.398155112068;6162.5378096642935;5738.540916726652;5749.137629355547;5756.251687280626;5775.306963164363;5783.363829978699;5174;5204.7918083277;5206.895862082737;5253.632245742761;5259.842204733787;6322.589031712924;6390.169277993831;6404.231492220963;6407.263164736022;6410.487161027107;6110.877782444415;6142.355052719578;6150.292716337678;6152.7538898445355;6152.984757515139;6151.84620384494;6257.56197066201;6336.366363363627;6355.078513615407;6392.584482008655;6058.242719660043;6060.454559089703;6064.423879731418;6078.665673388006;6092.147099405998;6149.200603921461;6151.231096112986;6152.815415537541;6162.26052873658;6171.259448866164;5851;5879.059350503899;5954.970225148846;5961.493273071837;5978.103284507359;5866.6186697864505;5908.911366329423;5909.6158749681135;5912.142739302863;5917.763289468373;5780.971095144498;5825.621334613236;5828.271466066742;5831.241938547962;5835.883282334415;5904.822855314347;5999.49004334619;6031.849203769941;6051.243594550681;6086.421789929949;5926.348101708895;5926.377730338425;5929.318128415288;5940.287165540163;5951.642901425928 05:40:14 INFO - PROCESS | 19440 | |1;ext.html;668.031354535923;668.5988406955827;673.0543586261301;683.364471041931;719.4496210399043;38821.61178388219;39496;39535.40696889549;39552;39571.2085758285;40925.7953710231;41267.380989285186;41286.38070428946;41606.58393416065;41613.375799363035;8538.573071346438;8784.429012114193;8805.20753132218;8806.691765788199;8807.2513836324;8640.135986401372;8923.866142007875;8942.463452192856;8967.596458159398;8978.86531702025;8916.465012099296;8933.59798809052;8939.55302234889;8948.105189481064;8963.731088067369;8908.688195913144;8952.104789521029;8960.955195224014;8973.820523589491;8977.326700497424;8799.032106468283;8918.152775486318;8919.152680495408;8944.776380590472;8971.372003959725;38261.80869095665;38676.22647547061;38742.61257387418;38749;38751.612483875084;3948.072203032285;4052.716309858311;4118.732282401635;4513.774311284423;4801.4718380978065;32286.354272914647;32503;32609.347813043845;32856.50715239273;33568.16079598005;4621.7920193591035;4641.744704041276;4688.554587314234;4696.342512048316;4744.667873248874;221058;223809;224193;224552.8772356144;224859;56886.43113568894;57382.7130864343;57411.425885741446;57474.7126264366;57495.71252143796;70283;70943.29056709471;70955.64522177356;71060.2893971064;71177;18932.621347573247;19085.141168647446;19136.712949305773;19264.133114009903;19264.229430822892;14573.708525829425;14688.118712877262;14688.55934321972;14699.338529766186;14797.556073317817;19788.604227915363;20497.2825951091;20607.278745244144;21149.471263218544;21235.68146477804;7594.886076708854;7686.461947663722;7755.12243878061;7788.922110778933;7789.532628042336;1095.1676725688535;1104.436737264001;1167.7430965187646;1173.1611897493333;1238.9407056966345;32892.105894585606;33480;33522.66477335196;33585.664143358255;33778.831105844314;1208.1542919956066;1249.4127759952808;1256.9057320700983;1330.9267990260435;1345.9394327255102;17360.826391736173;17416.129193540273;17579.56051098733;17638.559036024202;17775.644487110443;533476;600859;614340;616098;621502;60032.699836501415;61889;62007.379926201065;62251.68874155691;62630.0605490918;1571.1044704518315;1589.6423304756338;1595.146596570829;1597.9520614381354;1636.6399392133712;32765.836170818995;33122.5031624521;33313.666863331055;33821.661783382835;33821.661783382835;51981.7400912993;52744;52791.73604131955;52804.73597631987;52902.20646690226;480342;480565;487775;488828;489664;30700.692993069784;31046;31802;32023.679763203003;32036;48236.27645585389;49018.754906225244;49541.50458495369;49761.25358119559;50065.24902126398;41061.38407923824;42288.78855605702;42909.57090429056;42929.57070429381;43519;41865.58134418617;42649;42825.571744282155;42951.355729664705;43156.78421607872;36637;41961.160776784905;43478.78260608803;43611;44637;36659.266814663024;38139.85580432592;39042.80478597702;41226.175476490906;41515;28219;29051.709482905746;29116.417671646872;29118;29594 05:40:14 INFO - PROCESS | 19440 | |2;jquery.html;434.2725934060448;438.49353996134465;442.4955550672232;448.4170578248277;449.22060225508756;19306.420807375784;19485.220591176352;19940.40178794635;21198.152073917063;21209.151633934624;19583.118759655816;20033.699494507593;20286.797132028674;20604.278850240244;20859.061342239598;5689.374168841435;5995.790147344844;6003.489703375219;6021.946159422106;6029.60807547508;5832.6792026438525;5922;5958;5959.046552551593;5963.671998040106;5774.07614781635;5990.9400905990815;6001.2498437695285;6011.609245399057;6015.488683461911;5888.941110588882;5940.37626049263;5974.372690867462;5976.641401515923;5986;5489.231507588941;5795.652260864362;5812.157237200625;5816.941830581683;5817;21977;22123.225687100876;22496.55006899869;22522.211722589793;22704.97827597762;2373.4066483379156;2445.2786428003606;2463.519613675334;2521.9747802521924;2548.6304485849632;10344.94827525865;10538.683839484827;10846.457677116192;10961.397123158224;14292.785608215885;2022.2214447437696;2026.9189232430685;2038.7655419626785;2112.2290364017176;2160.5246845693923;77788;79084;80377.59811200907;86154.56922715346;87045.56477217573;11564.653060408202;11672;11677.416129193676;11682.357470339213;11966.64100076999;15983.680326393407;16126.596835079217;16165.515034548982;16183.19084045793;16228;8850.336224783166;9055.68305109318;9158;9197.172254496994;9281.443113413217;9084.22784063362;9129.863052054225;9139.451632902048;9160.129787670161;9280.7679808004;4910.484399138039;4913.508649135129;5095.235714642833;5222;5249.42256351801;2106.6629339305637;2108.8312934965165;2149.623815832223;2150.0862133593473;2172.8153106986083;956.990430095704;1033.7415646088477;1057.5663977769077;1065.2170654568886;1070.4433694478982;19089.427317180507;19098.188284539716;19410.611787764166;19635.920633493955;19714.112864921113;1079.9460026998618;1081.6863109698256;1151.9596814111633;1155.942202889852;1183.4378670131618;10947.56209751617;11099.667009989713;11146.944265278622;11165.720856978478;11266.830997535044;488055;493371;494036;497742;520291;58480.12279815721;59926.70036649789;95459.52270238605;97409;98509;1023.9078482936422;1031.7936412717486;1055.7624534479835;1142.857142857143;1163.988360116405;16945.602521394027;17240;17500.299988000846;17610.119494025505;17775.111244437983;26065.478690425705;32796.83601581977;40591.3911291325;40928.79535602303;41977.790111049246;59589.106163406715;60075;60312.69843650753;60447;60460.395396047235;9309.86035209486;9345.906540934504;9347.205487533636;9595;9628.18160456369;12751.93624031911;13978.860211397756;14001.719965600834;14029.719405611626;14292.785608216092;12125.454354553889;12143.635690928933;12291.69270768238;12342;12456.81314780261;11984.940075299568;12056.63830085099;12376.319302438093;12412.255264683787;12515.186512876633;7343.48595598303;12190.268583884641;12522.499100035897;12680.6829829255;12901.225926444444;9266;9356.532173391168;9376.718698439057;9397.812043759222;9526.380785248937;12532.686682833002;12535.373231338579;12574.37128143571;12701.55544555973;12792.424340904869 05:40:14 INFO - PROCESS | 19440 | |3;mootools.html;1559.2515592515592;1565.99217003915;1756.903370314633;1857.1642760757663;1872.1481725814756;7262.455315851319;7765.456418050739;8054.355651547877;8289.461185022978;8291.253787159154;7945.682172713085;7946.801329966754;8038.075621303552;8041.477303975237;8049.91950080499;2387.641853721947;2424.9030038798514;2429.0890915906534;2430;2434.902603895842;2461.1386014894824;2464.778169964703;2504.9248522544353;2505;2508.122157244968;2447.3881529617597;2451.154351748644;2452.3746444656585;2477.2568229531157;2478.5166892455977;2465.272744540356;2488.6515887775727;2490.2902672738273;2500.6999160100722;2509.77412032917;2488.639147323628;2501.524710305054;2501.5497210502103;2514.9874250628814;2522.823402361817;8394;8440.493570385797;8442.15578442157;8453.619587118534;8453.915460845374;5289.338832645919;5421.21392398104;5430.239766432703;5430.70131142787;5441.156620723794;3448.137965508623;3477.078574177845;3554.1470047188745;3567.8037707926055;3583.8208089595414;1280.4302085571924;1291.0833308351082;1303.6610481274936;1305.4467958566704;1310.7247478029626;11396.14528910335;11670.591529296435;11799.469023893946;11809.23239989398;11916.404179790976;4623.86128416148;4650.67445278834;4701.717896926195;4745.671212060629;4793.5685788279225;10112.393256404639;10137;10212.795744085077;10224.437655928847;10262.332948358482;5394.838154855361;5423.620346575702;5424.566034717213;5432.782688692487;5435.076037073707;4783.23468245086;4878.414590249193;4917.139500587383;4935.555799978019;4949.752512374367;3913.2173565287057;3957.8021098944937;3984.083660758042;3985.8405663773124;4059.04612416082;1219.8780121987909;1249.3877999780043;1251.0929576057285;1251.7121062155754;1255.7865162922142;943.9244860411151;946.5503885654259;1011.246621267146;1054.9261551691309;1056.5932116135343;5917.408259174134;5925.644461332334;5938.643681379045;6003.249593800775;6078.635281883101;466.43561290838466;470.2640367824412;471.0813912869849;474.077918448621;483.46818499650806;3890.105275786528;3918.2359439908946;3921.2353591049473;3973.0266084809405;3974.5230572331507;10201.489925503844;10500.632477863239;10542.631007914686;10587.470626468647;10611.946940265403;10341.689749307532;10385.117265032557;10440.843387349196;10463.42451165178;10470.685879423629;8121.837563248702;8156.184381561915;8231.34149268057;8251.752447426587;8265.710700125466;5632.127020311695;5644.548436125182;5666.858328541819;5697.316322041382;5909.084091965752;8880;9031.277497800029;9079.046700096394;9138.954305228697;9241.630334786802;9069.138431848964;9363.204127649225;9386.296027797805;9551.522423878918;9588.952055239679;7071.681774320065;7254.129504459499;7283.453740969342;7284.781456556312;7346.265373462611;7788.299053085249;7796.181400953045;7869.213078692085;7887.881681774663;7888.723894663659;7018.719251229893;7208.098987626547;7258.709651613876;7285.526440781332;7312.4881258313535;7061.187963384276;7082.220955694766;7098.893516597358;7119.85760284781;7175.31834475724;6553.80338589824;6753.1220941277315;6784.3554862288;6799.728010879509;6807.6596170190305;4950.975245123751;4951.282064100757;5021.322121513549;5046.091703493406;5079.085764562415;5044.747762611928;5087.465816089405;5089.796408143633;5141.305923700253;5144.897102058013 05:40:14 INFO - PROCESS | 19440 | |4;prototype.html;355.0484701001317;361.8552578968414;362.13630491278303;363.32421695646104;363.5128927237501;6524.412802847743;6593.307702691221;6601.240857301418;6639.302873198317;6652.06871038055;6503.382178693028;6521.576097553656;6532.608043517381;6532.706028228729;6542.640154791485;4824.975875120619;4946.72792996385;4952.752362381866;4972.627052971024;4988.426330971948;4952.678075925053;4963.35476388069;4970.179920313144;4987.376577927759;4988.451270360276;4915.655904086715;4926.753662316888;4931.679440836334;4945.653804233705;4950.87622809429;4935.185694360444;4939.580135688453;4951.851444456672;4961.603071754251;4969.130402179604;4302.41917341158;4312.3531470279395;4314.762688052156;4319.373690814846;4330.913381732379;6133.1413602095745;6272.905906411407;6313.305536390993;6316.557840951135;6343.365663433666;5704.800331988402;5710.685912274823;5724.112762521816;5745.195672605839;5763.942360576424;6936.132983377078;6939.965300173517;6940.895886561706;6943;6943.166819981584;4759.952400475986;4766.594839438651;4796.712197268175;4799.448063472711;4801.927971080437;7132.572045677224;7230.891536626955;7251.093613298338;7251.601161936092;7251.854962900765;4674.252119660838;4828.8792780180775;4836.879078023077;4857.587105096107;4867.805287788519;4908.435529914034;4918.11473934688;4918.311436398907;4920.040592084509;4923.77842997066;5731.426857314235;5732.168835518826;5736.225609542742;5736.282964629421;5737.799177028784;6973.93026069743;6978.441724662015;6986.825329366807;6994.545354551938;7002.894956575656;1726.3698749956175;1748.8950662960262;1751.6584266067994;1751.8861274017147;1754.1141723429587;1106.9169812264113;1133.1841074426566;1139.4758411130806;1146.7878442488;1162.0529268646026;6752.93247067523;6764.255931847493;6780.932190678129;6782.796516104426;6784.185897692309;7105.822354441077;7157.463190260752;7166.211716711262;7186.784396468114;7189.454267332549;6842.828929276709;6846.315368463114;6849.349311815369;6855.245922948472;6863.862722745517;3881.107345310594;3890.144168282973;3913.745606535566;3916.74541154824;3919.353306704419;7634.351080158138;7636.160022397532;7638.121616014229;7640.465167438337;7645.00614920068;7240.637968101574;7360.889586656204;7364.926350736531;7377.372923301472;7380.483366164317;7592;7602.707539718262;7615.390768738488;7633.0458692663415;7645.770626881203;7237.1677257114;7238.0952380952385;7246.746363877239;7250.746223882139;7256.895500304852;7109;7116.430685545248;7123;7123.252058533986;7144.749933752294;7475.252474752481;7524.097108347033;7603.543787372775;7613.428992825449;7637.121731000784;4839.741667166632;4883.95116048835;4896.510348965075;4899.1426500363;4907.631927605373;7195.712171513081;7203.531770434905;7207.5675459472595;7216.3505284524645;7222;6957.721691132298;6971.5468494547695;6981;6985.650717464005;6994;6773.491988101011;6855.485838562028;6959.0605268290155;6987.790366289019;7021.473389495706;6860.759873404407;6887.586744795329;6892.862142757016;6901.275366086689;6919.37725604698;7008.824779380557;7020.7893763187185;7054.823629409306;7068.858622827617;7074.575525468488;6908.240093589801;6908.861822763416;6909.2745261746795;6925.826854328682;6927.58434493932 05:40:14 INFO - PROCESS | 19440 | |5;yui.html;947.1530515494785;951.6954574536147;953.4803532075023;963.7638778499266;977.4917043137573;14841.851581484181;14901.105933643976;15130.243487825606;15428.460003899865;15540.533783986499;13919.93040034801;13971.720565588683;14046.297685115755;14046.438142474315;14065.226412547307;884.3853521802317;889.8576227803553;907.1835348186619;907.5689047702355;915.3135148638521;912.63494602159;918.9264858811279;923.7921467669754;923.8475651517491;927.7958849053231;963.734972882456;963.9951800240989;964.6286179820785;965.034965034965;965.1892410375283;950.273041123541;954.5370495309769;955.9665411710627;956.3162338927665;957.0525180071713;703.5110598134298;703.6692754405422;705.3334598804132;706.929307069294;707.2432497227968;16071.758923616155;16110.838891611169;16131.919340403223;16163.272652730539;16163.272652730655;13190.406431710597;13324.666883327995;13359.599212023655;13377.130486518443;13504;11828.112891533083;12028.63914082579;12054.276743395336;12084.758304833942;12266.81599776004;4042.9797851010558;4057.3913912913004;4086.6730661547003;4101.200265948141;4102.835886564534;57849.71075144597;58335;58435.123473147934;58532.99999999957;58740.412595874346;11374.459249862497;11663.300201987739;11785.705357365963;11792.646220613395;11815.645530634094;21041.368758937257;21072.894635526725;21082.262120825697;21112.261070862754;21143;8377.6230069647;8423.915760842436;8477.109903460172;8519.446235994641;8706.564671766513;5122.948770512322;5128.461511541234;5135.075686376488;5180.274761533388;5373.2208829719475;3547.432410814309;3548.591911930161;3605.729570282187;3617.4573813928123;3618.095476130967;637.4740838808002;660.1813750948885;661.6162625677096;666.3403230801568;681.151965802579;787.9724209652635;795.5783434779576;835.1731785532401;849.1169184048644;870.3124531619949;9814;10039.799204016024;10080.445575493419;10105.344525156757;10170.333217460338;680.6936878404738;755.3239850333921;794.4637369775379;819.8278361544143;827.5200383777394;4650.697704649187;4676.95323046772;4718.2214934536105;4728.550787675165;4849.781759820817;67799.66100169468;68220.6588967052;68287;68301.65849170822;68352.31647683459;55998;56825.715871421206;57194;58883.70558147182;58981.11528327079;52777;53054;53177.46822531803;53262.201066984024;54151.45848541543;9088.409253398508;9140.131687489678;9158.221551168226;9315.441073535609;9351.111644393772;38324.425133623576;39124.608753913235;39407.40888886611;40139.79930100331;41162.79418602888;45827.3125903105;47247.29129063136;49784.751076244385;50501;50993;10099.76915379522;10319.432431216355;10418.270721049454;10421.114205292635;10733.892661073289;13122.14706044104;13134.474621015052;13340;13571.050026498051;13640.181589104686;11942;12365.814512782135;12735.108542401942;12736.6815829605;12847.164934279243;11792.646220613395;11817.231879927776;12073.27560346382;12179.269243845398;12583.748325033632;11946.76106477883;12067.57763478274;12071.57749478764;12208.206466579644;12807.551735689578;9033.277337813091;9277.536123193679;9338.859917101385;9409.106134917172;9827.705168844946;9656.37233579815;9984.550695218588;9993.600255989679;10125.291229613857;10130.645427410005 05:40:14 INFO - PROCESS | 19440 | __end_tp_report 05:40:14 INFO - PROCESS | 19440 | __start_cc_report 05:40:14 INFO - PROCESS | 19440 | _x_x_mozilla_cycle_collect,330 05:40:14 INFO - PROCESS | 19440 | __end_cc_report 05:40:14 INFO - PROCESS | 19440 | __startTimestamp1469104814163__endTimestamp 05:40:14 INFO - PROCESS | 19440 | 05:40:14 INFO - PROCESS | 19440 | ------- Summary: start ------- 05:40:14 INFO - PROCESS | 19440 | Number of tests: 6 05:40:14 INFO - PROCESS | 19440 | 05:40:14 INFO - PROCESS | 19440 | [#0] dojo.html Cycles:165 Average:5669.47 Median:5909.62 stddev:628.80 (10.6%) stddev-sans-first:603.81 05:40:14 INFO - PROCESS | 19440 | Values: 3349.0 3423.6 3426.7 3430.7 3440.7 5655.2 5667.5 5686.1 5712.3 5714.1 5658.0 5671.6 5704.9 5708.5 5712.7 5077.4 5146.3 5202.8 5236.0 5268.5 5129.0 5205.1 5318.4 5319.5 5340.6 5152.4 5212.3 5240.4 5286.6 5317.8 5205.1 5222.5 5227.1 5227.3 5232.4 5054.4 5136.5 5181.0 5202.2 5239.5 5467.1 5567.2 5611.7 5621.5 5664.7 6028.4 6062.9 6064.1 6065.2 6074.4 6090.1 6115.8 6117.3 6123.9 6124.3 5658.2 5683.1 5723.5 5735.3 5739.5 6209.0 6213.3 6215.9 6216.0 6220.3 5978.4 5989.0 5998.6 6032.5 6090.0 6028.5 6046.4 6049.9 6050.1 6081.5 6013.9 6019.6 6022.6 6022.7 6029.7 5943.8 5956.7 6054.5 6108.3 6139.7 4574.9 4583.0 4629.8 4632.0 4665.4 4164.4 4169.2 4179.4 4187.2 4228.1 5880.6 5880.9 5914.5 5920.7 5959.4 5927.7 6034.2 6064.8 6122.4 6162.5 5738.5 5749.1 5756.3 5775.3 5783.4 5174.0 5204.8 5206.9 5253.6 5259.8 6322.6 6390.2 6404.2 6407.3 6410.5 6110.9 6142.4 6150.3 6152.8 6153.0 6151.8 6257.6 6336.4 6355.1 6392.6 6058.2 6060.5 6064.4 6078.7 6092.1 6149.2 6151.2 6152.8 6162.3 6171.3 5851.0 5879.1 5955.0 5961.5 5978.1 5866.6 5908.9 5909.6 5912.1 5917.8 5781.0 5825.6 5828.3 5831.2 5835.9 5904.8 5999.5 6031.8 6051.2 6086.4 5926.3 5926.4 5929.3 5940.3 5951.6 05:40:14 INFO - PROCESS | 19440 | 05:40:14 INFO - PROCESS | 19440 | [#1] ext.html Cycles:180 Average:60620.13 Median:41913.37 stddev:123631.64 (295.0%) stddev-sans-first:123896.52 05:40:14 INFO - PROCESS | 19440 | Values: 668.0 668.6 673.1 683.4 719.4 38821.6 39496.0 39535.4 39552.0 39571.2 40925.8 41267.4 41286.4 41606.6 41613.4 8538.6 8784.4 8805.2 8806.7 8807.3 8640.1 8923.9 8942.5 8967.6 8978.9 8916.5 8933.6 8939.6 8948.1 8963.7 8908.7 8952.1 8961.0 8973.8 8977.3 8799.0 8918.2 8919.2 8944.8 8971.4 38261.8 38676.2 38742.6 38749.0 38751.6 3948.1 4052.7 4118.7 4513.8 4801.5 32286.4 32503.0 32609.3 32856.5 33568.2 4621.8 4641.7 4688.6 4696.3 4744.7 221058.0 223809.0 224193.0 224552.9 224859.0 56886.4 57382.7 57411.4 57474.7 57495.7 70283.0 70943.3 70955.6 71060.3 71177.0 18932.6 19085.1 19136.7 19264.1 19264.2 14573.7 14688.1 14688.6 14699.3 14797.6 19788.6 20497.3 20607.3 21149.5 21235.7 7594.9 7686.5 7755.1 7788.9 7789.5 1095.2 1104.4 1167.7 1173.2 1238.9 32892.1 33480.0 33522.7 33585.7 33778.8 1208.2 1249.4 1256.9 1330.9 1345.9 17360.8 17416.1 17579.6 17638.6 17775.6 533476.0 600859.0 614340.0 616098.0 621502.0 60032.7 61889.0 62007.4 62251.7 62630.1 1571.1 1589.6 1595.1 1598.0 1636.6 32765.8 33122.5 33313.7 33821.7 33821.7 51981.7 52744.0 52791.7 52804.7 52902.2 480342.0 480565.0 487775.0 488828.0 489664.0 30700.7 31046.0 31802.0 32023.7 32036.0 48236.3 49018.8 49541.5 49761.3 50065.2 41061.4 42288.8 42909.6 42929.6 43519.0 41865.6 42649.0 42825.6 42951.4 43156.8 36637.0 41961.2 43478.8 43611.0 44637.0 36659.3 38139.9 39042.8 41226.2 41515.0 28219.0 29051.7 29116.4 29118.0 29594.0 05:40:14 INFO - PROCESS | 19440 | 05:40:14 INFO - PROCESS | 19440 | [#2] jquery.html Cycles:180 Average:29278.51 Median:22509.38 stddev:82010.10 (364.3%) stddev-sans-first:82211.56 05:40:14 INFO - PROCESS | 19440 | Values: 434.3 438.5 442.5 448.4 449.2 19306.4 19485.2 19940.4 21198.2 21209.2 19583.1 20033.7 20286.8 20604.3 20859.1 5689.4 5995.8 6003.5 6021.9 6029.6 5832.7 5922.0 5958.0 5959.0 5963.7 5774.1 5990.9 6001.2 6011.6 6015.5 5888.9 5940.4 5974.4 5976.6 5986.0 5489.2 5795.7 5812.2 5816.9 5817.0 21977.0 22123.2 22496.6 22522.2 22705.0 2373.4 2445.3 2463.5 2522.0 2548.6 10344.9 10538.7 10846.5 10961.4 14292.8 2022.2 2026.9 2038.8 2112.2 2160.5 77788.0 79084.0 80377.6 86154.6 87045.6 11564.7 11672.0 11677.4 11682.4 11966.6 15983.7 16126.6 16165.5 16183.2 16228.0 8850.3 9055.7 9158.0 9197.2 9281.4 9084.2 9129.9 9139.5 9160.1 9280.8 4910.5 4913.5 5095.2 5222.0 5249.4 2106.7 2108.8 2149.6 2150.1 2172.8 957.0 1033.7 1057.6 1065.2 1070.4 19089.4 19098.2 19410.6 19635.9 19714.1 1079.9 1081.7 1152.0 1155.9 1183.4 10947.6 11099.7 11146.9 11165.7 11266.8 488055.0 493371.0 494036.0 497742.0 520291.0 58480.1 59926.7 95459.5 97409.0 98509.0 1023.9 1031.8 1055.8 1142.9 1164.0 16945.6 17240.0 17500.3 17610.1 17775.1 26065.5 32796.8 40591.4 40928.8 41977.8 59589.1 60075.0 60312.7 60447.0 60460.4 9309.9 9345.9 9347.2 9595.0 9628.2 12751.9 13978.9 14001.7 14029.7 14292.8 12125.5 12143.6 12291.7 12342.0 12456.8 11984.9 12056.6 12376.3 12412.3 12515.2 7343.5 12190.3 12522.5 12680.7 12901.2 9266.0 9356.5 9376.7 9397.8 9526.4 12532.7 12535.4 12574.4 12701.6 12792.4 05:40:14 INFO - PROCESS | 19440 | 05:40:14 INFO - PROCESS | 19440 | [#3] mootools.html Cycles:180 Average:5605.20 Median:4926.35 stddev:3050.13 (61.9%) stddev-sans-first:3043.53 05:40:14 INFO - PROCESS | 19440 | Values: 1559.3 1566.0 1756.9 1857.2 1872.1 7262.5 7765.5 8054.4 8289.5 8291.3 7945.7 7946.8 8038.1 8041.5 8049.9 2387.6 2424.9 2429.1 2430.0 2434.9 2461.1 2464.8 2504.9 2505.0 2508.1 2447.4 2451.2 2452.4 2477.3 2478.5 2465.3 2488.7 2490.3 2500.7 2509.8 2488.6 2501.5 2501.5 2515.0 2522.8 8394.0 8440.5 8442.2 8453.6 8453.9 5289.3 5421.2 5430.2 5430.7 5441.2 3448.1 3477.1 3554.1 3567.8 3583.8 1280.4 1291.1 1303.7 1305.4 1310.7 11396.1 11670.6 11799.5 11809.2 11916.4 4623.9 4650.7 4701.7 4745.7 4793.6 10112.4 10137.0 10212.8 10224.4 10262.3 5394.8 5423.6 5424.6 5432.8 5435.1 4783.2 4878.4 4917.1 4935.6 4949.8 3913.2 3957.8 3984.1 3985.8 4059.0 1219.9 1249.4 1251.1 1251.7 1255.8 943.9 946.6 1011.2 1054.9 1056.6 5917.4 5925.6 5938.6 6003.2 6078.6 466.4 470.3 471.1 474.1 483.5 3890.1 3918.2 3921.2 3973.0 3974.5 10201.5 10500.6 10542.6 10587.5 10611.9 10341.7 10385.1 10440.8 10463.4 10470.7 8121.8 8156.2 8231.3 8251.8 8265.7 5632.1 5644.5 5666.9 5697.3 5909.1 8880.0 9031.3 9079.0 9139.0 9241.6 9069.1 9363.2 9386.3 9551.5 9589.0 7071.7 7254.1 7283.5 7284.8 7346.3 7788.3 7796.2 7869.2 7887.9 7888.7 7018.7 7208.1 7258.7 7285.5 7312.5 7061.2 7082.2 7098.9 7119.9 7175.3 6553.8 6753.1 6784.4 6799.7 6807.7 4951.0 4951.3 5021.3 5046.1 5079.1 5044.7 5087.5 5089.8 5141.3 5144.9 05:40:14 INFO - PROCESS | 19440 | 05:40:14 INFO - PROCESS | 19440 | [#4] prototype.html Cycles:180 Average:5832.50 Median:6758.59 stddev:1790.57 (26.5%) stddev-sans-first:1747.75 05:40:14 INFO - PROCESS | 19440 | Values: 355.0 361.9 362.1 363.3 363.5 6524.4 6593.3 6601.2 6639.3 6652.1 6503.4 6521.6 6532.6 6532.7 6542.6 4825.0 4946.7 4952.8 4972.6 4988.4 4952.7 4963.4 4970.2 4987.4 4988.5 4915.7 4926.8 4931.7 4945.7 4950.9 4935.2 4939.6 4951.9 4961.6 4969.1 4302.4 4312.4 4314.8 4319.4 4330.9 6133.1 6272.9 6313.3 6316.6 6343.4 5704.8 5710.7 5724.1 5745.2 5763.9 6936.1 6940.0 6940.9 6943.0 6943.2 4760.0 4766.6 4796.7 4799.4 4801.9 7132.6 7230.9 7251.1 7251.6 7251.9 4674.3 4828.9 4836.9 4857.6 4867.8 4908.4 4918.1 4918.3 4920.0 4923.8 5731.4 5732.2 5736.2 5736.3 5737.8 6973.9 6978.4 6986.8 6994.5 7002.9 1726.4 1748.9 1751.7 1751.9 1754.1 1106.9 1133.2 1139.5 1146.8 1162.1 6752.9 6764.3 6780.9 6782.8 6784.2 7105.8 7157.5 7166.2 7186.8 7189.5 6842.8 6846.3 6849.3 6855.2 6863.9 3881.1 3890.1 3913.7 3916.7 3919.4 7634.4 7636.2 7638.1 7640.5 7645.0 7240.6 7360.9 7364.9 7377.4 7380.5 7592.0 7602.7 7615.4 7633.0 7645.8 7237.2 7238.1 7246.7 7250.7 7256.9 7109.0 7116.4 7123.0 7123.3 7144.7 7475.3 7524.1 7603.5 7613.4 7637.1 4839.7 4884.0 4896.5 4899.1 4907.6 7195.7 7203.5 7207.6 7216.4 7222.0 6957.7 6971.5 6981.0 6985.7 6994.0 6773.5 6855.5 6959.1 6987.8 7021.5 6860.8 6887.6 6892.9 6901.3 6919.4 7008.8 7020.8 7054.8 7068.9 7074.6 6908.2 6908.9 6909.3 6925.8 6927.6 05:40:14 INFO - PROCESS | 19440 | 05:40:14 INFO - PROCESS | 19440 | [#5] yui.html Cycles:180 Average:15621.50 Median:28057.97 stddev:18501.81 (65.9%) stddev-sans-first:18520.90 05:40:14 INFO - PROCESS | 19440 | Values: 947.2 951.7 953.5 963.8 977.5 14841.9 14901.1 15130.2 15428.5 15540.5 13919.9 13971.7 14046.3 14046.4 14065.2 884.4 889.9 907.2 907.6 915.3 912.6 918.9 923.8 923.8 927.8 963.7 964.0 964.6 965.0 965.2 950.3 954.5 956.0 956.3 957.1 703.5 703.7 705.3 706.9 707.2 16071.8 16110.8 16131.9 16163.3 16163.3 13190.4 13324.7 13359.6 13377.1 13504.0 11828.1 12028.6 12054.3 12084.8 12266.8 4043.0 4057.4 4086.7 4101.2 4102.8 57849.7 58335.0 58435.1 58533.0 58740.4 11374.5 11663.3 11785.7 11792.6 11815.6 21041.4 21072.9 21082.3 21112.3 21143.0 8377.6 8423.9 8477.1 8519.4 8706.6 5122.9 5128.5 5135.1 5180.3 5373.2 3547.4 3548.6 3605.7 3617.5 3618.1 637.5 660.2 661.6 666.3 681.2 788.0 795.6 835.2 849.1 870.3 9814.0 10039.8 10080.4 10105.3 10170.3 680.7 755.3 794.5 819.8 827.5 4650.7 4677.0 4718.2 4728.6 4849.8 67799.7 68220.7 68287.0 68301.7 68352.3 55998.0 56825.7 57194.0 58883.7 58981.1 52777.0 53054.0 53177.5 53262.2 54151.5 9088.4 9140.1 9158.2 9315.4 9351.1 38324.4 39124.6 39407.4 40139.8 41162.8 45827.3 47247.3 49784.8 50501.0 50993.0 10099.8 10319.4 10418.3 10421.1 10733.9 13122.1 13134.5 13340.0 13571.1 13640.2 11942.0 12365.8 12735.1 12736.7 12847.2 11792.6 11817.2 12073.3 12179.3 12583.7 11946.8 12067.6 12071.6 12208.2 12807.6 9033.3 9277.5 9338.9 9409.1 9827.7 9656.4 9984.6 9993.6 10125.3 10130.6 05:40:14 INFO - PROCESS | 19440 | -------- Summary: end -------- 05:40:14 INFO - PROCESS | 19440 | 05:40:14 INFO - TEST-INFO | 19440: exit 0 05:40:14 INFO - TEST-OK | dromaeo_css | took 1109731ms 05:40:14 INFO - TEST-START | kraken 05:40:14 INFO - operating with platform_type : linux_ 05:40:14 INFO - Initialising browser for kraken test... 05:40:14 INFO - TEST-INFO | started process 19680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWqXKLN/profile http://localhost:54531/getInfo.html) 05:40:19 INFO - PROCESS | 19680 | 05:40:19 INFO - PROCESS | 19680 | (process:19756): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:19 INFO - PROCESS | 19680 | __metrics Screen width/height:1600/1200 05:40:19 INFO - PROCESS | 19680 | colorDepth:24 05:40:19 INFO - PROCESS | 19680 | Browser inner width/height: 1024/697 05:40:19 INFO - PROCESS | 19680 | __metrics 05:40:20 ERROR - PROCESS | 19680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:40:21 INFO - TEST-INFO | 19680: exit 0 05:40:21 INFO - Browser initialized. 05:40:21 INFO - Running cycle 1/1 for kraken test... 05:40:21 INFO - TEST-INFO | started process 19806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWqXKLN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:23 INFO - PROCESS | 19806 | 05:40:23 INFO - PROCESS | 19806 | (process:19872): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:33 INFO - PROCESS | 19806 | RSS: Main: 150859776 05:40:33 INFO - PROCESS | 19806 | 05:40:35 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54531/tests/kraken/driver.html?testName=audio-beat-detection) 05:40:36 INFO - PROCESS | 19806 | RSS: Main: 156213248 05:40:36 INFO - PROCESS | 19806 | 05:40:39 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54531/tests/kraken/driver.html?testName=audio-dft) 05:40:39 INFO - PROCESS | 19806 | RSS: Main: 156086272 05:40:39 INFO - PROCESS | 19806 | 05:40:42 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54531/tests/kraken/driver.html?testName=audio-fft) 05:40:43 INFO - PROCESS | 19806 | RSS: Main: 156196864 05:40:43 INFO - PROCESS | 19806 | 05:40:45 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54531/tests/kraken/driver.html?testName=audio-oscillator) 05:40:46 INFO - PROCESS | 19806 | RSS: Main: 155660288 05:40:46 INFO - PROCESS | 19806 | 05:40:48 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54531/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:48 INFO - PROCESS | 19806 | RSS: Main: 155803648 05:40:48 INFO - PROCESS | 19806 | 05:40:51 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54531/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:52 INFO - PROCESS | 19806 | RSS: Main: 156430336 05:40:52 INFO - PROCESS | 19806 | 05:40:55 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54531/tests/kraken/driver.html?testName=imaging-desaturate) 05:40:56 INFO - PROCESS | 19806 | RSS: Main: 156180480 05:40:56 INFO - PROCESS | 19806 | 05:40:59 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54531/tests/kraken/driver.html?testName=json-parse-financial) 05:40:59 INFO - PROCESS | 19806 | RSS: Main: 156229632 05:40:59 INFO - PROCESS | 19806 | 05:41:01 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54531/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:02 INFO - PROCESS | 19806 | RSS: Main: 156073984 05:41:02 INFO - PROCESS | 19806 | 05:41:03 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54531/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:04 INFO - PROCESS | 19806 | RSS: Main: 156172288 05:41:04 INFO - PROCESS | 19806 | 05:41:06 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54531/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:07 INFO - PROCESS | 19806 | RSS: Main: 156499968 05:41:07 INFO - PROCESS | 19806 | 05:41:09 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:10 INFO - PROCESS | 19806 | RSS: Main: 156905472 05:41:10 INFO - PROCESS | 19806 | 05:41:12 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:13 INFO - PROCESS | 19806 | RSS: Main: 156721152 05:41:13 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | Cycle 1(1): loaded http://localhost:54531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54531/tests/kraken/driver.html?testName=ai-astar) 05:41:15 INFO - PROCESS | 19806 | RSS: Main: 158203904 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | __start_tp_report 05:41:15 INFO - PROCESS | 19806 | _x_x_mozilla_page_load 05:41:15 INFO - PROCESS | 19806 | _x_x_mozilla_page_load_details 05:41:15 INFO - PROCESS | 19806 | |i|pagename|runs| 05:41:15 INFO - PROCESS | 19806 | |0;ai-astar;109;111;105;110;111;115;101;112;111;112 05:41:15 INFO - PROCESS | 19806 | |1;audio-beat-detection;157;128;160;184;132;164;156;130;204;127 05:41:15 INFO - PROCESS | 19806 | |2;audio-dft;162;165;163;163;163;162;162;164;161;166 05:41:15 INFO - PROCESS | 19806 | |3;audio-fft;75;76;77;193;77;76;76;75;150;75 05:41:15 INFO - PROCESS | 19806 | |4;audio-oscillator;96;92;161;92;93;98;152;92;92;138 05:41:15 INFO - PROCESS | 19806 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;119;117;118 05:41:15 INFO - PROCESS | 19806 | |6;imaging-darkroom;150;146;146;198;146;147;146;147;146;146 05:41:15 INFO - PROCESS | 19806 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 05:41:15 INFO - PROCESS | 19806 | |8;json-parse-financial;64;56;56;57;56;59;56;72;61;55 05:41:15 INFO - PROCESS | 19806 | |9;json-stringify-tinderbox;59;59;59;60;58;59;61;59;59;59 05:41:15 INFO - PROCESS | 19806 | |10;stanford-crypto-aes;73;75;71;76;75;73;74;75;74;75 05:41:15 INFO - PROCESS | 19806 | |11;stanford-crypto-ccm;123;117;122;119;115;116;114;116;135;129 05:41:15 INFO - PROCESS | 19806 | |12;stanford-crypto-pbkdf2;162;165;162;159;168;164;168;172;172;169 05:41:15 INFO - PROCESS | 19806 | |13;stanford-crypto-sha256-iterative;70;71;65;67;68;68;66;65;68;68 05:41:15 INFO - PROCESS | 19806 | __end_tp_report 05:41:15 INFO - PROCESS | 19806 | __start_cc_report 05:41:15 INFO - PROCESS | 19806 | _x_x_mozilla_cycle_collect,836 05:41:15 INFO - PROCESS | 19806 | __end_cc_report 05:41:15 INFO - PROCESS | 19806 | __startTimestamp1469104875357__endTimestamp 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | ------- Summary: start ------- 05:41:15 INFO - PROCESS | 19806 | Number of tests: 14 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.97 (3.6%) stddev-sans-first:4.21 05:41:15 INFO - PROCESS | 19806 | Values: 109.0 111.0 105.0 110.0 111.0 115.0 101.0 112.0 111.0 112.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:158.50 stddev:25.85 (16.3%) stddev-sans-first:27.40 05:41:15 INFO - PROCESS | 19806 | Values: 157.0 128.0 160.0 184.0 132.0 164.0 156.0 130.0 204.0 127.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.52 (0.9%) stddev-sans-first:1.56 05:41:15 INFO - PROCESS | 19806 | Values: 162.0 165.0 163.0 163.0 163.0 162.0 162.0 164.0 161.0 166.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:41.58 (54.7%) stddev-sans-first:43.47 05:41:15 INFO - PROCESS | 19806 | Values: 75.0 76.0 77.0 193.0 77.0 76.0 76.0 75.0 150.0 75.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:92.00 stddev:28.03 (30.5%) stddev-sans-first:29.23 05:41:15 INFO - PROCESS | 19806 | Values: 96.0 92.0 161.0 92.0 93.0 98.0 152.0 92.0 92.0 138.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:41:15 INFO - PROCESS | 19806 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 119.0 117.0 118.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:146.50 stddev:16.28 (11.1%) stddev-sans-first:17.26 05:41:15 INFO - PROCESS | 19806 | Values: 150.0 146.0 146.0 198.0 146.0 147.0 146.0 147.0 146.0 146.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:41:15 INFO - PROCESS | 19806 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.00 stddev:5.31 (9.2%) stddev-sans-first:5.34 05:41:15 INFO - PROCESS | 19806 | Values: 64.0 56.0 56.0 57.0 56.0 59.0 56.0 72.0 61.0 55.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 05:41:15 INFO - PROCESS | 19806 | Values: 59.0 59.0 59.0 60.0 58.0 59.0 61.0 59.0 59.0 59.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:75.00 stddev:1.45 (1.9%) stddev-sans-first:1.48 05:41:15 INFO - PROCESS | 19806 | Values: 73.0 75.0 71.0 76.0 75.0 73.0 74.0 75.0 74.0 75.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.50 stddev:6.82 (5.7%) stddev-sans-first:7.18 05:41:15 INFO - PROCESS | 19806 | Values: 123.0 117.0 122.0 119.0 115.0 116.0 114.0 116.0 135.0 129.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:168.00 stddev:4.41 (2.6%) stddev-sans-first:4.42 05:41:15 INFO - PROCESS | 19806 | Values: 162.0 165.0 162.0 159.0 168.0 164.0 168.0 172.0 172.0 169.0 05:41:15 INFO - PROCESS | 19806 | 05:41:15 INFO - PROCESS | 19806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.96 (2.9%) stddev-sans-first:1.87 05:41:15 INFO - PROCESS | 19806 | Values: 70.0 71.0 65.0 67.0 68.0 68.0 66.0 65.0 68.0 68.0 05:41:15 INFO - PROCESS | 19806 | -------- Summary: end -------- 05:41:15 INFO - PROCESS | 19806 | 05:41:16 INFO - TEST-INFO | 19806: exit 0 05:41:16 INFO - TEST-OK | kraken | took 61412ms 05:41:16 INFO - SUITE-END | took 1171s 05:41:16 INFO - Completed test suite (00:19:31) 05:41:16 INFO - javascript benchmark 05:41:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.0287816533205, 3423.5720534933134, 3426.7087297579706, 3430.7255419566436, 3440.707539859111, 5655.151727240911, 5667.4615911488445, 5686.147077938312, 5712.257406537149, 5714.085746280596, 5657.9717101414535, 5671.574631902603, 5704.914426283609, 5708.543316534678, 5712.685802280873, 5077.365329333824, 5146.305248791421, 5202.843914682547, 5235.973820130913, 5268.499492548221, 5128.974355128219, 5205.115130427836, 5318.361796584396, 5319.521243088121, 5340.62615616907, 5152.381714194302, 5212.270282160501, 5240.423553409122, 5286.577073834103, 5317.813876514323, 5205.141151709982, 5222.477752224785, 5227.137522308814, 5227.320448341691, 5232.424433312332, 5054.393472783253, 5136.512031357015, 5181.0, 5202.219667049935, 5239.528442440199, 5467.0705979983495, 5567.164925261202, 5611.719414029323, 5621.494065534122, 5664.688442135681, 6028.39716028398, 6062.9090563641585, 6064.06007068905, 6065.181200537959, 6074.3621919698235, 6090.056041313604, 6115.847103822395, 6117.265928088614, 6123.938760612381, 6124.326324104345, 5658.179563963202, 5683.090705487102, 5723.484886360247, 5735.340435849889, 5739.483446489836, 6209.0, 6213.285472170668, 6215.9378406216265, 6215.96892015537, 6220.284667263232, 5978.372270911492, 5989.0, 5998.580099393001, 6032.517398608101, 6090.025595904723, 6028.457438830438, 6046.3651316612, 6049.909251361233, 6050.062240352752, 6081.452669259788, 6013.939860601426, 6019.638821670714, 6022.608530445507, 6022.728977196037, 6029.698515074228, 5943.821685349447, 5956.6723830188885, 6054.455099041019, 6108.267007959073, 6139.723712432951, 4574.8507767580495, 4583.037562111994, 4629.768511574408, 4632.0, 4665.370175026328, 4164.416981622575, 4169.207850508455, 4179.414881916534, 4187.24629566681, 4228.133232687292, 5880.558958078162, 5880.941190588125, 5914.497267732291, 5920.674362909996, 5959.374265702126, 5927.673977931255, 6034.2155519782145, 6064.787732429344, 6122.398155112068, 6162.5378096642935, 5738.540916726652, 5749.137629355547, 5756.251687280626, 5775.306963164363, 5783.363829978699, 5174.0, 5204.7918083277, 5206.895862082737, 5253.632245742761, 5259.842204733787, 6322.589031712924, 6390.169277993831, 6404.231492220963, 6407.263164736022, 6410.487161027107, 6110.877782444415, 6142.355052719578, 6150.292716337678, 6152.7538898445355, 6152.984757515139, 6151.84620384494, 6257.56197066201, 6336.366363363627, 6355.078513615407, 6392.584482008655, 6058.242719660043, 6060.454559089703, 6064.423879731418, 6078.665673388006, 6092.147099405998, 6149.200603921461, 6151.231096112986, 6152.815415537541, 6162.26052873658, 6171.259448866164, 5851.0, 5879.059350503899, 5954.970225148846, 5961.493273071837, 5978.103284507359, 5866.6186697864505, 5908.911366329423, 5909.6158749681135, 5912.142739302863, 5917.763289468373, 5780.971095144498, 5825.621334613236, 5828.271466066742, 5831.241938547962, 5835.883282334415, 5904.822855314347, 5999.49004334619, 6031.849203769941, 6051.243594550681, 6086.421789929949, 5926.348101708895, 5926.377730338425, 5929.318128415288, 5940.287165540163, 5951.642901425928], "value": 5628.498128111792, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.031354535923, 668.5988406955827, 673.0543586261301, 683.364471041931, 719.4496210399043, 38821.61178388219, 39496.0, 39535.40696889549, 39552.0, 39571.2085758285, 40925.7953710231, 41267.380989285186, 41286.38070428946, 41606.58393416065, 41613.375799363035, 8538.573071346438, 8784.429012114193, 8805.20753132218, 8806.691765788199, 8807.2513836324, 8640.135986401372, 8923.866142007875, 8942.463452192856, 8967.596458159398, 8978.86531702025, 8916.465012099296, 8933.59798809052, 8939.55302234889, 8948.105189481064, 8963.731088067369, 8908.688195913144, 8952.104789521029, 8960.955195224014, 8973.820523589491, 8977.326700497424, 8799.032106468283, 8918.152775486318, 8919.152680495408, 8944.776380590472, 8971.372003959725, 38261.80869095665, 38676.22647547061, 38742.61257387418, 38749.0, 38751.612483875084, 3948.072203032285, 4052.716309858311, 4118.732282401635, 4513.774311284423, 4801.4718380978065, 32286.354272914647, 32503.0, 32609.347813043845, 32856.50715239273, 33568.16079598005, 4621.7920193591035, 4641.744704041276, 4688.554587314234, 4696.342512048316, 4744.667873248874, 221058.0, 223809.0, 224193.0, 224552.8772356144, 224859.0, 56886.43113568894, 57382.7130864343, 57411.425885741446, 57474.7126264366, 57495.71252143796, 70283.0, 70943.29056709471, 70955.64522177356, 71060.2893971064, 71177.0, 18932.621347573247, 19085.141168647446, 19136.712949305773, 19264.133114009903, 19264.229430822892, 14573.708525829425, 14688.118712877262, 14688.55934321972, 14699.338529766186, 14797.556073317817, 19788.604227915363, 20497.2825951091, 20607.278745244144, 21149.471263218544, 21235.68146477804, 7594.886076708854, 7686.461947663722, 7755.12243878061, 7788.922110778933, 7789.532628042336, 1095.1676725688535, 1104.436737264001, 1167.7430965187646, 1173.1611897493333, 1238.9407056966345, 32892.105894585606, 33480.0, 33522.66477335196, 33585.664143358255, 33778.831105844314, 1208.1542919956066, 1249.4127759952808, 1256.9057320700983, 1330.9267990260435, 1345.9394327255102, 17360.826391736173, 17416.129193540273, 17579.56051098733, 17638.559036024202, 17775.644487110443, 533476.0, 600859.0, 614340.0, 616098.0, 621502.0, 60032.699836501415, 61889.0, 62007.379926201065, 62251.68874155691, 62630.0605490918, 1571.1044704518315, 1589.6423304756338, 1595.146596570829, 1597.9520614381354, 1636.6399392133712, 32765.836170818995, 33122.5031624521, 33313.666863331055, 33821.661783382835, 33821.661783382835, 51981.7400912993, 52744.0, 52791.73604131955, 52804.73597631987, 52902.20646690226, 480342.0, 480565.0, 487775.0, 488828.0, 489664.0, 30700.692993069784, 31046.0, 31802.0, 32023.679763203003, 32036.0, 48236.27645585389, 49018.754906225244, 49541.50458495369, 49761.25358119559, 50065.24902126398, 41061.38407923824, 42288.78855605702, 42909.57090429056, 42929.57070429381, 43519.0, 41865.58134418617, 42649.0, 42825.571744282155, 42951.355729664705, 43156.78421607872, 36637.0, 41961.160776784905, 43478.78260608803, 43611.0, 44637.0, 36659.266814663024, 38139.85580432592, 39042.80478597702, 41226.175476490906, 41515.0, 28219.0, 29051.709482905746, 29116.417671646872, 29118.0, 29594.0], "value": 20971.058406443626, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.2725934060448, 438.49353996134465, 442.4955550672232, 448.4170578248277, 449.22060225508756, 19306.420807375784, 19485.220591176352, 19940.40178794635, 21198.152073917063, 21209.151633934624, 19583.118759655816, 20033.699494507593, 20286.797132028674, 20604.278850240244, 20859.061342239598, 5689.374168841435, 5995.790147344844, 6003.489703375219, 6021.946159422106, 6029.60807547508, 5832.6792026438525, 5922.0, 5958.0, 5959.046552551593, 5963.671998040106, 5774.07614781635, 5990.9400905990815, 6001.2498437695285, 6011.609245399057, 6015.488683461911, 5888.941110588882, 5940.37626049263, 5974.372690867462, 5976.641401515923, 5986.0, 5489.231507588941, 5795.652260864362, 5812.157237200625, 5816.941830581683, 5817.0, 21977.0, 22123.225687100876, 22496.55006899869, 22522.211722589793, 22704.97827597762, 2373.4066483379156, 2445.2786428003606, 2463.519613675334, 2521.9747802521924, 2548.6304485849632, 10344.94827525865, 10538.683839484827, 10846.457677116192, 10961.397123158224, 14292.785608215885, 2022.2214447437696, 2026.9189232430685, 2038.7655419626785, 2112.2290364017176, 2160.5246845693923, 77788.0, 79084.0, 80377.59811200907, 86154.56922715346, 87045.56477217573, 11564.653060408202, 11672.0, 11677.416129193676, 11682.357470339213, 11966.64100076999, 15983.680326393407, 16126.596835079217, 16165.515034548982, 16183.19084045793, 16228.0, 8850.336224783166, 9055.68305109318, 9158.0, 9197.172254496994, 9281.443113413217, 9084.22784063362, 9129.863052054225, 9139.451632902048, 9160.129787670161, 9280.7679808004, 4910.484399138039, 4913.508649135129, 5095.235714642833, 5222.0, 5249.42256351801, 2106.6629339305637, 2108.8312934965165, 2149.623815832223, 2150.0862133593473, 2172.8153106986083, 956.990430095704, 1033.7415646088477, 1057.5663977769077, 1065.2170654568886, 1070.4433694478982, 19089.427317180507, 19098.188284539716, 19410.611787764166, 19635.920633493955, 19714.112864921113, 1079.9460026998618, 1081.6863109698256, 1151.9596814111633, 1155.942202889852, 1183.4378670131618, 10947.56209751617, 11099.667009989713, 11146.944265278622, 11165.720856978478, 11266.830997535044, 488055.0, 493371.0, 494036.0, 497742.0, 520291.0, 58480.12279815721, 59926.70036649789, 95459.52270238605, 97409.0, 98509.0, 1023.9078482936422, 1031.7936412717486, 1055.7624534479835, 1142.857142857143, 1163.988360116405, 16945.602521394027, 17240.0, 17500.299988000846, 17610.119494025505, 17775.111244437983, 26065.478690425705, 32796.83601581977, 40591.3911291325, 40928.79535602303, 41977.790111049246, 59589.106163406715, 60075.0, 60312.69843650753, 60447.0, 60460.395396047235, 9309.86035209486, 9345.906540934504, 9347.205487533636, 9595.0, 9628.18160456369, 12751.93624031911, 13978.860211397756, 14001.719965600834, 14029.719405611626, 14292.785608216092, 12125.454354553889, 12143.635690928933, 12291.69270768238, 12342.0, 12456.81314780261, 11984.940075299568, 12056.63830085099, 12376.319302438093, 12412.255264683787, 12515.186512876633, 7343.48595598303, 12190.268583884641, 12522.499100035897, 12680.6829829255, 12901.225926444444, 9266.0, 9356.532173391168, 9376.718698439057, 9397.812043759222, 9526.380785248937, 12532.686682833002, 12535.373231338579, 12574.37128143571, 12701.55544555973, 12792.424340904869], "value": 9648.778065269165, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1559.2515592515592, 1565.99217003915, 1756.903370314633, 1857.1642760757663, 1872.1481725814756, 7262.455315851319, 7765.456418050739, 8054.355651547877, 8289.461185022978, 8291.253787159154, 7945.682172713085, 7946.801329966754, 8038.075621303552, 8041.477303975237, 8049.91950080499, 2387.641853721947, 2424.9030038798514, 2429.0890915906534, 2430.0, 2434.902603895842, 2461.1386014894824, 2464.778169964703, 2504.9248522544353, 2505.0, 2508.122157244968, 2447.3881529617597, 2451.154351748644, 2452.3746444656585, 2477.2568229531157, 2478.5166892455977, 2465.272744540356, 2488.6515887775727, 2490.2902672738273, 2500.6999160100722, 2509.77412032917, 2488.639147323628, 2501.524710305054, 2501.5497210502103, 2514.9874250628814, 2522.823402361817, 8394.0, 8440.493570385797, 8442.15578442157, 8453.619587118534, 8453.915460845374, 5289.338832645919, 5421.21392398104, 5430.239766432703, 5430.70131142787, 5441.156620723794, 3448.137965508623, 3477.078574177845, 3554.1470047188745, 3567.8037707926055, 3583.8208089595414, 1280.4302085571924, 1291.0833308351082, 1303.6610481274936, 1305.4467958566704, 1310.7247478029626, 11396.14528910335, 11670.591529296435, 11799.469023893946, 11809.23239989398, 11916.404179790976, 4623.86128416148, 4650.67445278834, 4701.717896926195, 4745.671212060629, 4793.5685788279225, 10112.393256404639, 10137.0, 10212.795744085077, 10224.437655928847, 10262.332948358482, 5394.838154855361, 5423.620346575702, 5424.566034717213, 5432.782688692487, 5435.076037073707, 4783.23468245086, 4878.414590249193, 4917.139500587383, 4935.555799978019, 4949.752512374367, 3913.2173565287057, 3957.8021098944937, 3984.083660758042, 3985.8405663773124, 4059.04612416082, 1219.8780121987909, 1249.3877999780043, 1251.0929576057285, 1251.7121062155754, 1255.7865162922142, 943.9244860411151, 946.5503885654259, 1011.246621267146, 1054.9261551691309, 1056.5932116135343, 5917.408259174134, 5925.644461332334, 5938.643681379045, 6003.249593800775, 6078.635281883101, 466.43561290838466, 470.2640367824412, 471.0813912869849, 474.077918448621, 483.46818499650806, 3890.105275786528, 3918.2359439908946, 3921.2353591049473, 3973.0266084809405, 3974.5230572331507, 10201.489925503844, 10500.632477863239, 10542.631007914686, 10587.470626468647, 10611.946940265403, 10341.689749307532, 10385.117265032557, 10440.843387349196, 10463.42451165178, 10470.685879423629, 8121.837563248702, 8156.184381561915, 8231.34149268057, 8251.752447426587, 8265.710700125466, 5632.127020311695, 5644.548436125182, 5666.858328541819, 5697.316322041382, 5909.084091965752, 8880.0, 9031.277497800029, 9079.046700096394, 9138.954305228697, 9241.630334786802, 9069.138431848964, 9363.204127649225, 9386.296027797805, 9551.522423878918, 9588.952055239679, 7071.681774320065, 7254.129504459499, 7283.453740969342, 7284.781456556312, 7346.265373462611, 7788.299053085249, 7796.181400953045, 7869.213078692085, 7887.881681774663, 7888.723894663659, 7018.719251229893, 7208.098987626547, 7258.709651613876, 7285.526440781332, 7312.4881258313535, 7061.187963384276, 7082.220955694766, 7098.893516597358, 7119.85760284781, 7175.31834475724, 6553.80338589824, 6753.1220941277315, 6784.3554862288, 6799.728010879509, 6807.6596170190305, 4950.975245123751, 4951.282064100757, 5021.322121513549, 5046.091703493406, 5079.085764562415, 5044.747762611928, 5087.465816089405, 5089.796408143633, 5141.305923700253, 5144.897102058013], "value": 4519.411594407984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.0484701001317, 361.8552578968414, 362.13630491278303, 363.32421695646104, 363.5128927237501, 6524.412802847743, 6593.307702691221, 6601.240857301418, 6639.302873198317, 6652.06871038055, 6503.382178693028, 6521.576097553656, 6532.608043517381, 6532.706028228729, 6542.640154791485, 4824.975875120619, 4946.72792996385, 4952.752362381866, 4972.627052971024, 4988.426330971948, 4952.678075925053, 4963.35476388069, 4970.179920313144, 4987.376577927759, 4988.451270360276, 4915.655904086715, 4926.753662316888, 4931.679440836334, 4945.653804233705, 4950.87622809429, 4935.185694360444, 4939.580135688453, 4951.851444456672, 4961.603071754251, 4969.130402179604, 4302.41917341158, 4312.3531470279395, 4314.762688052156, 4319.373690814846, 4330.913381732379, 6133.1413602095745, 6272.905906411407, 6313.305536390993, 6316.557840951135, 6343.365663433666, 5704.800331988402, 5710.685912274823, 5724.112762521816, 5745.195672605839, 5763.942360576424, 6936.132983377078, 6939.965300173517, 6940.895886561706, 6943.0, 6943.166819981584, 4759.952400475986, 4766.594839438651, 4796.712197268175, 4799.448063472711, 4801.927971080437, 7132.572045677224, 7230.891536626955, 7251.093613298338, 7251.601161936092, 7251.854962900765, 4674.252119660838, 4828.8792780180775, 4836.879078023077, 4857.587105096107, 4867.805287788519, 4908.435529914034, 4918.11473934688, 4918.311436398907, 4920.040592084509, 4923.77842997066, 5731.426857314235, 5732.168835518826, 5736.225609542742, 5736.282964629421, 5737.799177028784, 6973.93026069743, 6978.441724662015, 6986.825329366807, 6994.545354551938, 7002.894956575656, 1726.3698749956175, 1748.8950662960262, 1751.6584266067994, 1751.8861274017147, 1754.1141723429587, 1106.9169812264113, 1133.1841074426566, 1139.4758411130806, 1146.7878442488, 1162.0529268646026, 6752.93247067523, 6764.255931847493, 6780.932190678129, 6782.796516104426, 6784.185897692309, 7105.822354441077, 7157.463190260752, 7166.211716711262, 7186.784396468114, 7189.454267332549, 6842.828929276709, 6846.315368463114, 6849.349311815369, 6855.245922948472, 6863.862722745517, 3881.107345310594, 3890.144168282973, 3913.745606535566, 3916.74541154824, 3919.353306704419, 7634.351080158138, 7636.160022397532, 7638.121616014229, 7640.465167438337, 7645.00614920068, 7240.637968101574, 7360.889586656204, 7364.926350736531, 7377.372923301472, 7380.483366164317, 7592.0, 7602.707539718262, 7615.390768738488, 7633.0458692663415, 7645.770626881203, 7237.1677257114, 7238.0952380952385, 7246.746363877239, 7250.746223882139, 7256.895500304852, 7109.0, 7116.430685545248, 7123.0, 7123.252058533986, 7144.749933752294, 7475.252474752481, 7524.097108347033, 7603.543787372775, 7613.428992825449, 7637.121731000784, 4839.741667166632, 4883.95116048835, 4896.510348965075, 4899.1426500363, 4907.631927605373, 7195.712171513081, 7203.531770434905, 7207.5675459472595, 7216.3505284524645, 7222.0, 6957.721691132298, 6971.5468494547695, 6981.0, 6985.650717464005, 6994.0, 6773.491988101011, 6855.485838562028, 6959.0605268290155, 6987.790366289019, 7021.473389495706, 6860.759873404407, 6887.586744795329, 6892.862142757016, 6901.275366086689, 6919.37725604698, 7008.824779380557, 7020.7893763187185, 7054.823629409306, 7068.858622827617, 7074.575525468488, 6908.240093589801, 6908.861822763416, 6909.2745261746795, 6925.826854328682, 6927.58434493932], "value": 5244.7125879866335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [947.1530515494785, 951.6954574536147, 953.4803532075023, 963.7638778499266, 977.4917043137573, 14841.851581484181, 14901.105933643976, 15130.243487825606, 15428.460003899865, 15540.533783986499, 13919.93040034801, 13971.720565588683, 14046.297685115755, 14046.438142474315, 14065.226412547307, 884.3853521802317, 889.8576227803553, 907.1835348186619, 907.5689047702355, 915.3135148638521, 912.63494602159, 918.9264858811279, 923.7921467669754, 923.8475651517491, 927.7958849053231, 963.734972882456, 963.9951800240989, 964.6286179820785, 965.034965034965, 965.1892410375283, 950.273041123541, 954.5370495309769, 955.9665411710627, 956.3162338927665, 957.0525180071713, 703.5110598134298, 703.6692754405422, 705.3334598804132, 706.929307069294, 707.2432497227968, 16071.758923616155, 16110.838891611169, 16131.919340403223, 16163.272652730539, 16163.272652730655, 13190.406431710597, 13324.666883327995, 13359.599212023655, 13377.130486518443, 13504.0, 11828.112891533083, 12028.63914082579, 12054.276743395336, 12084.758304833942, 12266.81599776004, 4042.9797851010558, 4057.3913912913004, 4086.6730661547003, 4101.200265948141, 4102.835886564534, 57849.71075144597, 58335.0, 58435.123473147934, 58532.99999999957, 58740.412595874346, 11374.459249862497, 11663.300201987739, 11785.705357365963, 11792.646220613395, 11815.645530634094, 21041.368758937257, 21072.894635526725, 21082.262120825697, 21112.261070862754, 21143.0, 8377.6230069647, 8423.915760842436, 8477.109903460172, 8519.446235994641, 8706.564671766513, 5122.948770512322, 5128.461511541234, 5135.075686376488, 5180.274761533388, 5373.2208829719475, 3547.432410814309, 3548.591911930161, 3605.729570282187, 3617.4573813928123, 3618.095476130967, 637.4740838808002, 660.1813750948885, 661.6162625677096, 666.3403230801568, 681.151965802579, 787.9724209652635, 795.5783434779576, 835.1731785532401, 849.1169184048644, 870.3124531619949, 9814.0, 10039.799204016024, 10080.445575493419, 10105.344525156757, 10170.333217460338, 680.6936878404738, 755.3239850333921, 794.4637369775379, 819.8278361544143, 827.5200383777394, 4650.697704649187, 4676.95323046772, 4718.2214934536105, 4728.550787675165, 4849.781759820817, 67799.66100169468, 68220.6588967052, 68287.0, 68301.65849170822, 68352.31647683459, 55998.0, 56825.715871421206, 57194.0, 58883.70558147182, 58981.11528327079, 52777.0, 53054.0, 53177.46822531803, 53262.201066984024, 54151.45848541543, 9088.409253398508, 9140.131687489678, 9158.221551168226, 9315.441073535609, 9351.111644393772, 38324.425133623576, 39124.608753913235, 39407.40888886611, 40139.79930100331, 41162.79418602888, 45827.3125903105, 47247.29129063136, 49784.751076244385, 50501.0, 50993.0, 10099.76915379522, 10319.432431216355, 10418.270721049454, 10421.114205292635, 10733.892661073289, 13122.14706044104, 13134.474621015052, 13340.0, 13571.050026498051, 13640.181589104686, 11942.0, 12365.814512782135, 12735.108542401942, 12736.6815829605, 12847.164934279243, 11792.646220613395, 11817.231879927776, 12073.27560346382, 12179.269243845398, 12583.748325033632, 11946.76106477883, 12067.57763478274, 12071.57749478764, 12208.206466579644, 12807.551735689578, 9033.277337813091, 9277.536123193679, 9338.859917101385, 9409.106134917172, 9827.705168844946, 9656.37233579815, 9984.550695218588, 9993.600255989679, 10125.291229613857, 10130.645427410005], "value": 7117.395419671199, "unit": "score"}], "name": "dromaeo_css", "value": 7596.40784076428, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 105.0, 110.0, 111.0, 115.0, 101.0, 112.0, 111.0, 112.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 160.0, 184.0, 132.0, 164.0, 156.0, 130.0, 204.0, 127.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 163.0, 163.0, 162.0, 162.0, 164.0, 161.0, 166.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 193.0, 77.0, 76.0, 76.0, 75.0, 150.0, 75.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 92.0, 161.0, 92.0, 93.0, 98.0, 152.0, 92.0, 92.0, 138.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 146.0, 198.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 56.0, 56.0, 57.0, 56.0, 59.0, 56.0, 72.0, 61.0, 55.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 58.0, 59.0, 61.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 71.0, 76.0, 75.0, 73.0, 74.0, 75.0, 74.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 117.0, 122.0, 119.0, 115.0, 116.0, 114.0, 116.0, 135.0, 129.0], "value": 120.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 162.0, 159.0, 168.0, 164.0, 168.0, 172.0, 172.0, 169.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 65.0, 67.0, 68.0, 68.0, 66.0, 65.0, 68.0, 68.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1543.6999999999996, "alertThreshold": 2.0}]} 05:41:16 INFO - Return code: 0 05:41:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:41:16 ERROR - # TBPL SUCCESS # 05:41:16 INFO - Running post-action listener: _resource_record_post_action 05:41:16 INFO - Running post-run listener: _resource_record_post_run 05:41:17 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 28672; Write bytes: 466595840; Read time: 20; Write time: 924100 05:41:17 INFO - install - Wall time: 14s; CPU: 20.0%; Read bytes: 0; Write bytes: 249393152; Read time: 0; Write time: 697252 05:41:17 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 28672; Write bytes: 216367104; Read time: 20; Write time: 226376 05:41:17 INFO - Running post-run listener: _upload_blobber_files 05:41:17 INFO - Blob upload gear active. 05:41:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:17 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 05:41:17 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:41:17 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:41:18 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:41:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:41:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:18 INFO - (blobuploader) - INFO - Done attempting. 05:41:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:41:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:41:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:20 INFO - (blobuploader) - INFO - Done attempting. 05:41:20 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:20 INFO - Return code: 0 05:41:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:41:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a89a366f1b856a9027f7f9a003579224cf13e547c358272598440fba861843b6eb4a496d10d8c22e6bf59a00919fcde5d214ef2aba8c00afa674a23566b7ad72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d622c3d691b50678b8d4289f0bd952e2c3a9890984980d43d33cacd707da9a0e7e8be0fee8078816e843b6e661d7b505edd78573fa3c6896d3e7497668c5e29"} 05:41:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:41:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:41:20 INFO - Contents: 05:41:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a89a366f1b856a9027f7f9a003579224cf13e547c358272598440fba861843b6eb4a496d10d8c22e6bf59a00919fcde5d214ef2aba8c00afa674a23566b7ad72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d622c3d691b50678b8d4289f0bd952e2c3a9890984980d43d33cacd707da9a0e7e8be0fee8078816e843b6e661d7b505edd78573fa3c6896d3e7497668c5e29"} 05:41:20 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:20 INFO - Copying logs to upload dir... 05:41:20 INFO - mkdir: /builds/slave/test/build/upload/logs 05:41:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.708523 ========= master_lag: 1.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-07-21 05:41:21.037267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 05:41:21.042829) ========= 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=745a4373a2a16df560f216e000000264-1469103653.893423-1995443440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a89a366f1b856a9027f7f9a003579224cf13e547c358272598440fba861843b6eb4a496d10d8c22e6bf59a00919fcde5d214ef2aba8c00afa674a23566b7ad72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d622c3d691b50678b8d4289f0bd952e2c3a9890984980d43d33cacd707da9a0e7e8be0fee8078816e843b6e661d7b505edd78573fa3c6896d3e7497668c5e29"} build_url:https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/M3tCu2g4T-yNJCdveqsd5Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a89a366f1b856a9027f7f9a003579224cf13e547c358272598440fba861843b6eb4a496d10d8c22e6bf59a00919fcde5d214ef2aba8c00afa674a23566b7ad72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d622c3d691b50678b8d4289f0bd952e2c3a9890984980d43d33cacd707da9a0e7e8be0fee8078816e843b6e661d7b505edd78573fa3c6896d3e7497668c5e29"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 05:41:21.068124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:41:21.068468) ========= 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=745a4373a2a16df560f216e000000264-1469103653.893423-1995443440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:41:21.120027) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 05:41:21.120406) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 05:41:21.120696) ========= ========= Total master_lag: 1.56 =========