builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1466505495.67 results: success (0) buildid: 20160621002602 builduid: f12a0d6b45e84a0b940c115d38687111 revision: fb2bd3009fd43b84acffa0eb62151e19c3eb4197 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:15.667588) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:15.668199) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:15.668528) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:15.686349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:15.686706) ========= 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=df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 03:38:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-06-21 03:38:16 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120831 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:15.847631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:15.847975) ========= 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=df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015362 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:15.960980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 03:38:15.961345) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fb2bd3009fd43b84acffa0eb62151e19c3eb4197 --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 fb2bd3009fd43b84acffa0eb62151e19c3eb4197 --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=df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 03:38:16,212 truncating revision to first 12 chars 2016-06-21 03:38:16,212 Setting DEBUG logging. 2016-06-21 03:38:16,212 attempt 1/10 2016-06-21 03:38:16,212 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fb2bd3009fd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 03:38:17,106 unpacking tar archive at: mozilla-beta-fb2bd3009fd4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.237382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 03:38:17.214245) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:17.214579) ========= script_repo_revision: fb2bd3009fd43b84acffa0eb62151e19c3eb4197 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:17.214977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:17.215250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 03:38:17.227806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-21 03:38:17.228241) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:38:17 INFO - MultiFileLogger online at 20160621 03:38:17 in /builds/slave/test 03:38:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:38:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:38:17 INFO - {'append_to_log': False, 03:38:17 INFO - 'base_work_dir': '/builds/slave/test', 03:38:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:38:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:38:17 INFO - 'branch': 'Mozilla-Beta', 03:38:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:38:17 INFO - 'config_files': ('talos/linux_config.py',), 03:38:17 INFO - 'default_actions': ('clobber', 03:38:17 INFO - 'read-buildbot-config', 03:38:17 INFO - 'download-and-extract', 03:38:17 INFO - 'populate-webroot', 03:38:17 INFO - 'create-virtualenv', 03:38:17 INFO - 'install', 03:38:17 INFO - 'run-tests'), 03:38:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:38:17 INFO - 'download_minidump_stackwalk': True, 03:38:17 INFO - 'download_symbols': 'ondemand', 03:38:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:38:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:38:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:38:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:38:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:38:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:38:17 INFO - 'installer_path': 'installer.exe', 03:38:17 INFO - 'log_level': 'info', 03:38:17 INFO - 'log_name': 'talos', 03:38:17 INFO - 'log_to_console': True, 03:38:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:38:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:38:17 INFO - 'opt_config_files': (), 03:38:17 INFO - 'pip_index': False, 03:38:17 INFO - 'sps_profile': False, 03:38:17 INFO - 'sps_profile_interval': 0, 03:38:17 INFO - 'suite': 'dromaeojs', 03:38:17 INFO - 'system_bits': '32', 03:38:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:38:17 INFO - 'title': 'talos-linux64-ix-021', 03:38:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:38:17 INFO - 'use_talos_json': True, 03:38:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:38:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:38:17 INFO - 'work_dir': 'build'} 03:38:17 INFO - ##### 03:38:17 INFO - ##### Running clobber step. 03:38:17 INFO - ##### 03:38:17 INFO - Running pre-action listener: _resource_record_pre_action 03:38:17 INFO - Running main action method: clobber 03:38:17 INFO - rmtree: /builds/slave/test/build 03:38:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:38:18 INFO - Running post-action listener: _resource_record_post_action 03:38:18 INFO - ##### 03:38:18 INFO - ##### Running read-buildbot-config step. 03:38:18 INFO - ##### 03:38:18 INFO - Running pre-action listener: _resource_record_pre_action 03:38:18 INFO - Running main action method: read_buildbot_config 03:38:18 INFO - Using buildbot properties: 03:38:18 INFO - { 03:38:18 INFO - "project": "", 03:38:18 INFO - "product": "firefox", 03:38:18 INFO - "script_repo_revision": "production", 03:38:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 03:38:18 INFO - "repository": "", 03:38:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 03:38:18 INFO - "buildid": "20160621002602", 03:38:18 INFO - "pgo_build": "True", 03:38:18 INFO - "basedir": "/builds/slave/test", 03:38:18 INFO - "buildnumber": 52, 03:38:18 INFO - "slavename": "talos-linux64-ix-021", 03:38:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:38:18 INFO - "platform": "ubuntu64_hw", 03:38:18 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:38:18 INFO - "branch": "mozilla-beta", 03:38:18 INFO - "repo_path": "releases/mozilla-beta", 03:38:18 INFO - "revision": "fb2bd3009fd43b84acffa0eb62151e19c3eb4197", 03:38:18 INFO - "stage_platform": "linux64-pgo", 03:38:18 INFO - "builduid": "f12a0d6b45e84a0b940c115d38687111", 03:38:18 INFO - "slavebuilddir": "test" 03:38:18 INFO - } 03:38:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 03:38:18 INFO - Running post-action listener: _resource_record_post_action 03:38:18 INFO - ##### 03:38:18 INFO - ##### Running download-and-extract step. 03:38:18 INFO - ##### 03:38:18 INFO - Running pre-action listener: _resource_record_pre_action 03:38:18 INFO - Running main action method: download_and_extract 03:38:18 INFO - mkdir: /builds/slave/test/build/tests 03:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:18 INFO - https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:38:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:38:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:38:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/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 03:38:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/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 03:38:21 INFO - Downloaded 1327 bytes. 03:38:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:38:21 INFO - Using the following test package requirements: 03:38:21 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:38:21 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:38:21 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:38:21 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:38:21 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 03:38:21 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:38:21 INFO - u'jsshell-linux-x86_64.zip'], 03:38:21 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:38:21 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:38:21 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:38:21 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:38:21 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 03:38:21 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:38:21 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 03:38:21 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:38:21 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:38:21 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:38:21 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:38:21 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:21 INFO - https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:38:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:38:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:38:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/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 03:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/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 03:38:22 INFO - Downloaded 24185729 bytes. 03:38:22 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'] 03:38:22 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 03:38:24 INFO - Return code: 0 03:38:24 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 03:38: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')]} 03:38:24 INFO - https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:38:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:38:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:38:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/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 03:38:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/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 03:38:27 INFO - Downloaded 24185729 bytes. 03:38:27 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'] 03:38:27 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 03:38:28 INFO - Return code: 0 03:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:28 INFO - https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/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 03:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/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 03:38:30 INFO - Downloaded 10840145 bytes. 03:38:30 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'] 03:38:30 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 03:38:30 INFO - Return code: 0 03:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:30 INFO - https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:38:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:38:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:38:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/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 03:38:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RL2Zuw8NQo6dg75yp2sgSA/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 03:38:32 INFO - Downloaded 56001072 bytes. 03:38:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:38:32 INFO - mkdir: /builds/slave/test/properties 03:38:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:38:32 INFO - Writing to file /builds/slave/test/properties/build_url 03:38:32 INFO - Contents: 03:38:32 INFO - build_url:https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:38:33 INFO - Running post-action listener: _resource_record_post_action 03:38:33 INFO - Running post-action listener: set_extra_try_arguments 03:38:33 INFO - ##### 03:38:33 INFO - ##### Running populate-webroot step. 03:38:33 INFO - ##### 03:38:33 INFO - Running pre-action listener: _resource_record_pre_action 03:38:33 INFO - Running main action method: populate_webroot 03:38:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:38:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:38:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:38:33 INFO - '--tppagecycles', 03:38:33 INFO - '7'], 03:38:33 INFO - 'tests': ['tsvgm']}}, 03:38:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:38:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:38:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:38:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:38:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:38:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:38:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:33 INFO - 'talos_options': ['--disable-e10s'], 03:38:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:33 INFO - 'talos_options': ['--disable-e10s'], 03:38:33 INFO - 'tests': ['damp', 'tps']}, 03:38:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:33 INFO - 'tests': ['damp', 'tps']}, 03:38:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:38:33 INFO - 'tests': ['dromaeo_dom']}, 03:38:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:38:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:38:33 INFO - 'tests': ['a11yr', 03:38:33 INFO - 'ts_paint', 03:38:33 INFO - 'tpaint', 03:38:33 INFO - 'sessionrestore', 03:38:33 INFO - 'sessionrestore_no_auto_restore', 03:38:33 INFO - 'tabpaint']}, 03:38:33 INFO - 'other-e10s': {'tests': ['a11yr', 03:38:33 INFO - 'ts_paint', 03:38:33 INFO - 'tpaint', 03:38:33 INFO - 'sessionrestore', 03:38:33 INFO - 'sessionrestore_no_auto_restore', 03:38:33 INFO - 'tabpaint']}, 03:38:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:38:33 INFO - 'ts_paint', 03:38:33 INFO - 'tpaint', 03:38:33 INFO - 'sessionrestore', 03:38:33 INFO - 'sessionrestore_no_auto_restore', 03:38:33 INFO - 'tabpaint']}, 03:38:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:38:33 INFO - 'ts_paint', 03:38:33 INFO - 'tpaint', 03:38:33 INFO - 'sessionrestore', 03:38:33 INFO - 'sessionrestore_no_auto_restore', 03:38:33 INFO - 'tabpaint']}, 03:38:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:38:33 INFO - 'tests': ['a11yr', 03:38:33 INFO - 'ts_paint', 03:38:33 INFO - 'tpaint', 03:38:33 INFO - 'sessionrestore', 03:38:33 INFO - 'sessionrestore_no_auto_restore', 03:38:33 INFO - 'tabpaint']}, 03:38:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:38:33 INFO - 'tests': ['a11yr', 03:38:33 INFO - 'ts_paint', 03:38:33 INFO - 'tpaint', 03:38:33 INFO - 'sessionrestore', 03:38:33 INFO - 'sessionrestore_no_auto_restore', 03:38:33 INFO - 'tabpaint']}, 03:38:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:38:33 INFO - 'tests': ['tsvgx', 03:38:33 INFO - 'tsvgr_opacity', 03:38:33 INFO - 'tart', 03:38:33 INFO - 'tscrollx', 03:38:33 INFO - 'cart']}, 03:38:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:38:33 INFO - 'tsvgr_opacity', 03:38:33 INFO - 'tart', 03:38:33 INFO - 'tscrollx', 03:38:33 INFO - 'cart']}, 03:38:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:33 INFO - 'talos_options': ['--disable-e10s'], 03:38:33 INFO - 'tests': ['tp5o']}, 03:38:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:33 INFO - 'tests': ['tp5o']}, 03:38:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:33 INFO - 'talos_options': ['--disable-e10s', 03:38:33 INFO - '--xperf_path', 03:38:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:33 INFO - 'tests': ['tp5n']}, 03:38:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:33 INFO - 'talos_options': ['--xperf_path', 03:38:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:33 INFO - 'tests': ['tp5n']}}, 03:38:33 INFO - 'talos.zip': {'path': '', 03:38:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:38:33 INFO - Running post-action listener: _resource_record_post_action 03:38:33 INFO - ##### 03:38:33 INFO - ##### Running create-virtualenv step. 03:38:33 INFO - ##### 03:38:33 INFO - Running pre-action listener: _resource_record_pre_action 03:38:33 INFO - Running main action method: create_virtualenv 03:38:33 INFO - Creating virtualenv /builds/slave/test/build/venv 03:38:33 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 03:38:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:38:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:38:33 INFO - Using real prefix '/usr' 03:38:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:38:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:38:36 INFO - Installing pip.................done. 03:38:36 INFO - Return code: 0 03:38:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1966c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233410>, '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 0x2234310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22347a0>, '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': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', '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 03:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:38:36 INFO - Using env: {'DISPLAY': ':0', 03:38:36 INFO - 'HOME': '/home/cltbld', 03:38:36 INFO - 'LANG': 'en_US.UTF-8', 03:38:36 INFO - 'LANGUAGE': 'en_US:en', 03:38:36 INFO - 'LOGNAME': 'cltbld', 03:38:36 INFO - 'MAIL': '/var/mail/cltbld', 03:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:36 INFO - 'MOZ_NO_REMOTE': '1', 03:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:36 INFO - 'NO_EM_RESTART': '1', 03:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:36 INFO - 'PWD': '/builds/slave/test', 03:38:36 INFO - 'SHELL': '/bin/bash', 03:38:36 INFO - 'SHLVL': '1', 03:38:36 INFO - 'TERM': 'linux', 03:38:36 INFO - 'TMOUT': '86400', 03:38:36 INFO - 'USER': 'cltbld', 03:38:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', 03:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:36 INFO - '_': '/tools/buildbot/bin/python'} 03:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:36 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 03:38:36 INFO - Cleaning up... 03:38:36 INFO - Return code: 0 03:38:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1966c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233410>, '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 0x2234310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22347a0>, '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': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', '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 03:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:38:36 INFO - Using env: {'DISPLAY': ':0', 03:38:36 INFO - 'HOME': '/home/cltbld', 03:38:36 INFO - 'LANG': 'en_US.UTF-8', 03:38:36 INFO - 'LANGUAGE': 'en_US:en', 03:38:36 INFO - 'LOGNAME': 'cltbld', 03:38:36 INFO - 'MAIL': '/var/mail/cltbld', 03:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:36 INFO - 'MOZ_NO_REMOTE': '1', 03:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:36 INFO - 'NO_EM_RESTART': '1', 03:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:36 INFO - 'PWD': '/builds/slave/test', 03:38:36 INFO - 'SHELL': '/bin/bash', 03:38:36 INFO - 'SHLVL': '1', 03:38:36 INFO - 'TERM': 'linux', 03:38:36 INFO - 'TMOUT': '86400', 03:38:36 INFO - 'USER': 'cltbld', 03:38:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', 03:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:36 INFO - '_': '/tools/buildbot/bin/python'} 03:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:36 INFO - Downloading/unpacking psutil>=0.7.1 03:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:38:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:38 INFO - Installing collected packages: psutil 03:38:38 INFO - Running setup.py install for psutil 03:38:38 INFO - building 'psutil._psutil_linux' extension 03:38:38 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 03:38:38 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 03:38:38 INFO - building 'psutil._psutil_posix' extension 03:38:38 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 03:38:38 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 03:38:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:39 INFO - Successfully installed psutil 03:38:39 INFO - Cleaning up... 03:38:39 INFO - Return code: 0 03:38:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:39 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 0x7fc1966c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233410>, '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 0x2234310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22347a0>, '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': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', '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 03:38:39 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 03:38:39 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 03:38:39 INFO - Using env: {'DISPLAY': ':0', 03:38:39 INFO - 'HOME': '/home/cltbld', 03:38:39 INFO - 'LANG': 'en_US.UTF-8', 03:38:39 INFO - 'LANGUAGE': 'en_US:en', 03:38:39 INFO - 'LOGNAME': 'cltbld', 03:38:39 INFO - 'MAIL': '/var/mail/cltbld', 03:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:39 INFO - 'MOZ_NO_REMOTE': '1', 03:38:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:39 INFO - 'NO_EM_RESTART': '1', 03:38:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:39 INFO - 'PWD': '/builds/slave/test', 03:38:39 INFO - 'SHELL': '/bin/bash', 03:38:39 INFO - 'SHLVL': '1', 03:38:39 INFO - 'TERM': 'linux', 03:38:39 INFO - 'TMOUT': '86400', 03:38:39 INFO - 'USER': 'cltbld', 03:38:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', 03:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:39 INFO - '_': '/tools/buildbot/bin/python'} 03:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:38:39 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 03:38:39 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 03:38:39 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 03:38:39 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 03:38:39 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 03:38:39 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 03:38:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:38:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:38:41 INFO - Installing collected packages: mozsystemmonitor 03:38:41 INFO - Running setup.py install for mozsystemmonitor 03:38:41 INFO - Successfully installed mozsystemmonitor 03:38:41 INFO - Cleaning up... 03:38:41 INFO - Return code: 0 03:38:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:38:41 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')]} 03:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:41 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')]} 03:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:41 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 0x7fc1966c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233410>, '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 0x2234310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22347a0>, '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': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', '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 03:38:41 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 03:38:41 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 03:38:41 INFO - Using env: {'DISPLAY': ':0', 03:38:41 INFO - 'HOME': '/home/cltbld', 03:38:41 INFO - 'LANG': 'en_US.UTF-8', 03:38:41 INFO - 'LANGUAGE': 'en_US:en', 03:38:41 INFO - 'LOGNAME': 'cltbld', 03:38:41 INFO - 'MAIL': '/var/mail/cltbld', 03:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:41 INFO - 'MOZ_NO_REMOTE': '1', 03:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:41 INFO - 'NO_EM_RESTART': '1', 03:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:41 INFO - 'PWD': '/builds/slave/test', 03:38:41 INFO - 'SHELL': '/bin/bash', 03:38:41 INFO - 'SHLVL': '1', 03:38:41 INFO - 'TERM': 'linux', 03:38:41 INFO - 'TMOUT': '86400', 03:38:41 INFO - 'USER': 'cltbld', 03:38:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', 03:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:41 INFO - '_': '/tools/buildbot/bin/python'} 03:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:41 INFO - Downloading/unpacking blobuploader==1.2.4 03:38:41 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 03:38:41 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 03:38:41 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 03:38:41 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 03:38:41 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 03:38:41 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 03:38:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:38:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:38:43 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 03:38:43 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 03:38:43 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 03:38:43 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 03:38:43 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 03:38:43 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 03:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:38:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:44 INFO - Downloading docopt-0.6.1.tar.gz 03:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:38:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:38:44 INFO - Running setup.py install for blobuploader 03:38:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:38:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:38:44 INFO - Running setup.py install for requests 03:38:44 INFO - Running setup.py install for docopt 03:38:44 INFO - Successfully installed blobuploader requests docopt 03:38:44 INFO - Cleaning up... 03:38:44 INFO - Return code: 0 03:38:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:44 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 0x7fc1966c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233410>, '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 0x2234310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22347a0>, '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': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', '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 03:38:44 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 03:38:44 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 03:38:44 INFO - Using env: {'DISPLAY': ':0', 03:38:44 INFO - 'HOME': '/home/cltbld', 03:38:44 INFO - 'LANG': 'en_US.UTF-8', 03:38:44 INFO - 'LANGUAGE': 'en_US:en', 03:38:44 INFO - 'LOGNAME': 'cltbld', 03:38:44 INFO - 'MAIL': '/var/mail/cltbld', 03:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:44 INFO - 'MOZ_NO_REMOTE': '1', 03:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:44 INFO - 'NO_EM_RESTART': '1', 03:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:44 INFO - 'PWD': '/builds/slave/test', 03:38:44 INFO - 'SHELL': '/bin/bash', 03:38:44 INFO - 'SHLVL': '1', 03:38:44 INFO - 'TERM': 'linux', 03:38:44 INFO - 'TMOUT': '86400', 03:38:44 INFO - 'USER': 'cltbld', 03:38:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', 03:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:44 INFO - '_': '/tools/buildbot/bin/python'} 03:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:45 INFO - Running setup.py (path:/tmp/pip-0rG045-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:45 INFO - Running setup.py (path:/tmp/pip-flB6yM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:45 INFO - Running setup.py (path:/tmp/pip-APWe22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:45 INFO - Running setup.py (path:/tmp/pip-ttYdaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:45 INFO - Running setup.py (path:/tmp/pip-f8opTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:45 INFO - Running setup.py (path:/tmp/pip-CcDKGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:45 INFO - Running setup.py (path:/tmp/pip-FS3Yag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:45 INFO - Running setup.py (path:/tmp/pip-rjtNsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:45 INFO - Running setup.py (path:/tmp/pip-0GNf1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:45 INFO - Running setup.py (path:/tmp/pip-mu2Jka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:45 INFO - Running setup.py (path:/tmp/pip-iHfrsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:45 INFO - Running setup.py (path:/tmp/pip-VbBidx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:46 INFO - Running setup.py (path:/tmp/pip-XfxpUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:46 INFO - Running setup.py (path:/tmp/pip-Jq2Ntq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:46 INFO - Running setup.py (path:/tmp/pip-7b2rMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:46 INFO - Running setup.py (path:/tmp/pip-DkQEsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:46 INFO - Running setup.py (path:/tmp/pip-ixctS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:38:46 INFO - Running setup.py install for manifestparser 03:38:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:38:46 INFO - Running setup.py install for mozcrash 03:38:46 INFO - Running setup.py install for mozdebug 03:38:46 INFO - Running setup.py install for mozdevice 03:38:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:38:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:38:46 INFO - Running setup.py install for mozfile 03:38:46 INFO - Running setup.py install for mozhttpd 03:38:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Running setup.py install for mozinfo 03:38:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Running setup.py install for mozInstall 03:38:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Running setup.py install for mozleak 03:38:47 INFO - Running setup.py install for mozlog 03:38:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Running setup.py install for moznetwork 03:38:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Running setup.py install for mozprocess 03:38:47 INFO - Running setup.py install for mozprofile 03:38:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Running setup.py install for mozrunner 03:38:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Running setup.py install for mozscreenshot 03:38:47 INFO - Running setup.py install for moztest 03:38:48 INFO - Running setup.py install for mozversion 03:38:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:38:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:38:48 INFO - Cleaning up... 03:38:48 INFO - Return code: 0 03:38:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:48 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 0x7fc1966c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233410>, '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 0x2234310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22347a0>, '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': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', '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 03:38:48 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 03:38:48 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 03:38:48 INFO - Using env: {'DISPLAY': ':0', 03:38:48 INFO - 'HOME': '/home/cltbld', 03:38:48 INFO - 'LANG': 'en_US.UTF-8', 03:38:48 INFO - 'LANGUAGE': 'en_US:en', 03:38:48 INFO - 'LOGNAME': 'cltbld', 03:38:48 INFO - 'MAIL': '/var/mail/cltbld', 03:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:48 INFO - 'MOZ_NO_REMOTE': '1', 03:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:48 INFO - 'NO_EM_RESTART': '1', 03:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:48 INFO - 'PWD': '/builds/slave/test', 03:38:48 INFO - 'SHELL': '/bin/bash', 03:38:48 INFO - 'SHLVL': '1', 03:38:48 INFO - 'TERM': 'linux', 03:38:48 INFO - 'TMOUT': '86400', 03:38:48 INFO - 'USER': 'cltbld', 03:38:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', 03:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:48 INFO - '_': '/tools/buildbot/bin/python'} 03:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:48 INFO - Running setup.py (path:/tmp/pip-GWCa_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:48 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)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:48 INFO - Running setup.py (path:/tmp/pip-g6nZ7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:48 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)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:48 INFO - Running setup.py (path:/tmp/pip-4eh5Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:48 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)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:48 INFO - Running setup.py (path:/tmp/pip-GNxiBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:48 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)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:48 INFO - Running setup.py (path:/tmp/pip-L6Bmn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:48 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)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:48 INFO - Running setup.py (path:/tmp/pip-OHo7B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:48 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)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:48 INFO - Running setup.py (path:/tmp/pip-5FsPMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:48 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)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:48 INFO - Running setup.py (path:/tmp/pip-mccOm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:48 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)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:48 INFO - Running setup.py (path:/tmp/pip-SkoASY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:49 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)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:49 INFO - Running setup.py (path:/tmp/pip-EPV4iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:49 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)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:49 INFO - Running setup.py (path:/tmp/pip-vhCWku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:49 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)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:49 INFO - Running setup.py (path:/tmp/pip-SGP20d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:49 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)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:49 INFO - Running setup.py (path:/tmp/pip-Br3b7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:49 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)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:49 INFO - Running setup.py (path:/tmp/pip-um510s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:49 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)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:49 INFO - Running setup.py (path:/tmp/pip-wujpJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:49 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)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:49 INFO - Running setup.py (path:/tmp/pip-McfBuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:49 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)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:49 INFO - Running setup.py (path:/tmp/pip-d4ab6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:49 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)) 03:38:49 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)) 03:38:49 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)) 03:38:49 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)) 03:38:49 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)) 03:38:49 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)) 03:38:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:51 INFO - Downloading blessings-1.6.tar.gz 03:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:38:51 INFO - Installing collected packages: blessings 03:38:51 INFO - Running setup.py install for blessings 03:38:51 INFO - Successfully installed blessings 03:38:51 INFO - Cleaning up... 03:38:51 INFO - Return code: 0 03:38:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:38:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:51 INFO - Reading from file tmpfile_stdout 03:38:51 INFO - Current package versions: 03:38:51 INFO - argparse == 1.2.1 03:38:51 INFO - blessings == 1.6 03:38:51 INFO - blobuploader == 1.2.4 03:38:51 INFO - docopt == 0.6.1 03:38:51 INFO - manifestparser == 1.1 03:38:51 INFO - mozInstall == 1.12 03:38:51 INFO - mozcrash == 0.17 03:38:51 INFO - mozdebug == 0.1 03:38:51 INFO - mozdevice == 0.48 03:38:51 INFO - mozfile == 1.2 03:38:51 INFO - mozhttpd == 0.7 03:38:51 INFO - mozinfo == 0.9 03:38:51 INFO - mozleak == 0.1 03:38:51 INFO - mozlog == 3.1 03:38:51 INFO - moznetwork == 0.27 03:38:51 INFO - mozprocess == 0.22 03:38:51 INFO - mozprofile == 0.28 03:38:51 INFO - mozrunner == 6.11 03:38:51 INFO - mozscreenshot == 0.1 03:38:51 INFO - mozsystemmonitor == 0.0 03:38:51 INFO - moztest == 0.7 03:38:51 INFO - mozversion == 1.4 03:38:51 INFO - psutil == 3.1.1 03:38:51 INFO - requests == 1.2.3 03:38:51 INFO - wsgiref == 0.1.2 03:38:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:51 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 0x7fc1966c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233410>, '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 0x2234310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22347a0>, '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': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', '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 03:38:51 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 03:38:51 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 03:38:52 INFO - Using env: {'DISPLAY': ':0', 03:38:52 INFO - 'HOME': '/home/cltbld', 03:38:52 INFO - 'LANG': 'en_US.UTF-8', 03:38:52 INFO - 'LANGUAGE': 'en_US:en', 03:38:52 INFO - 'LOGNAME': 'cltbld', 03:38:52 INFO - 'MAIL': '/var/mail/cltbld', 03:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:52 INFO - 'MOZ_NO_REMOTE': '1', 03:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:52 INFO - 'NO_EM_RESTART': '1', 03:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:52 INFO - 'PWD': '/builds/slave/test', 03:38:52 INFO - 'SHELL': '/bin/bash', 03:38:52 INFO - 'SHLVL': '1', 03:38:52 INFO - 'TERM': 'linux', 03:38:52 INFO - 'TMOUT': '86400', 03:38:52 INFO - 'USER': 'cltbld', 03:38:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', 03:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:52 INFO - '_': '/tools/buildbot/bin/python'} 03:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:52 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)) 03:38:52 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)) 03:38:52 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)) 03:38:52 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)) 03:38:52 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)) 03:38:52 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)) 03:38:52 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)) 03:38:52 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)) 03:38:52 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)) 03:38:52 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)) 03:38:52 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)) 03:38:52 INFO - Cleaning up... 03:38:52 INFO - Return code: 0 03:38:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:38:52 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')]} 03:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:52 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')]} 03:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:52 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 0x7fc1966c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233410>, '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 0x2234310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22347a0>, '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': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', '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 03:38:52 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 03:38:52 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 03:38:52 INFO - Using env: {'DISPLAY': ':0', 03:38:52 INFO - 'HOME': '/home/cltbld', 03:38:52 INFO - 'LANG': 'en_US.UTF-8', 03:38:52 INFO - 'LANGUAGE': 'en_US:en', 03:38:52 INFO - 'LOGNAME': 'cltbld', 03:38:52 INFO - 'MAIL': '/var/mail/cltbld', 03:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:52 INFO - 'MOZ_NO_REMOTE': '1', 03:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:52 INFO - 'NO_EM_RESTART': '1', 03:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:52 INFO - 'PWD': '/builds/slave/test', 03:38:52 INFO - 'SHELL': '/bin/bash', 03:38:52 INFO - 'SHLVL': '1', 03:38:52 INFO - 'TERM': 'linux', 03:38:52 INFO - 'TMOUT': '86400', 03:38:52 INFO - 'USER': 'cltbld', 03:38:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', 03:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:52 INFO - '_': '/tools/buildbot/bin/python'} 03:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:52 INFO - Downloading/unpacking jsonschema 03:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:38:54 INFO - Downloading/unpacking functools32 (from jsonschema) 03:38:54 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 03:38:54 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 03:38:54 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 03:38:54 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 03:38:54 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 03:38:54 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 03:38:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:38:54 INFO - warning: no files found matching '*.txt' 03:38:54 INFO - no previously-included directories found matching 'build' 03:38:54 INFO - no previously-included directories found matching 'dist' 03:38:54 INFO - no previously-included directories found matching '.git*' 03:38:54 INFO - Installing collected packages: jsonschema, functools32 03:38:54 INFO - Running setup.py install for functools32 03:38:54 INFO - warning: no files found matching '*.txt' 03:38:54 INFO - no previously-included directories found matching 'build' 03:38:54 INFO - no previously-included directories found matching 'dist' 03:38:54 INFO - no previously-included directories found matching '.git*' 03:38:54 INFO - Successfully installed jsonschema functools32 03:38:54 INFO - Cleaning up... 03:38:54 INFO - Return code: 0 03:38:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:38:54 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')]} 03:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:54 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')]} 03:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:54 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 0x7fc1966c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233410>, '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 0x2234310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22347a0>, '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': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', '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 03:38:54 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 03:38:54 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 03:38:54 INFO - Using env: {'DISPLAY': ':0', 03:38:54 INFO - 'HOME': '/home/cltbld', 03:38:54 INFO - 'LANG': 'en_US.UTF-8', 03:38:54 INFO - 'LANGUAGE': 'en_US:en', 03:38:54 INFO - 'LOGNAME': 'cltbld', 03:38:54 INFO - 'MAIL': '/var/mail/cltbld', 03:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:54 INFO - 'MOZ_NO_REMOTE': '1', 03:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:54 INFO - 'NO_EM_RESTART': '1', 03:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:54 INFO - 'PWD': '/builds/slave/test', 03:38:54 INFO - 'SHELL': '/bin/bash', 03:38:54 INFO - 'SHLVL': '1', 03:38:54 INFO - 'TERM': 'linux', 03:38:54 INFO - 'TMOUT': '86400', 03:38:54 INFO - 'USER': 'cltbld', 03:38:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', 03:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:54 INFO - '_': '/tools/buildbot/bin/python'} 03:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:55 INFO - Downloading/unpacking flake8 03:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:38:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:38:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:38:57 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 03:38:57 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 03:38:57 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 03:38:57 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 03:38:57 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 03:38:57 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 03:38:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:38:57 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 03:38:57 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 03:38:57 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 03:38:57 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 03:38:57 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 03:38:57 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 03:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:38:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:38:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:38:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:38:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:38:57 INFO - no previously-included directories found matching 'docs/_build' 03:38:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:38:57 INFO - Running setup.py install for pep8 03:38:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:38:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:38:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:38:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:38:57 INFO - no previously-included directories found matching 'docs/_build' 03:38:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:38:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:38:57 INFO - Cleaning up... 03:38:57 INFO - Return code: 0 03:38:57 INFO - Running post-action listener: _resource_record_post_action 03:38:57 INFO - Running post-action listener: _start_resource_monitoring 03:38:57 INFO - Starting resource monitoring. 03:38:57 INFO - ##### 03:38:57 INFO - ##### Running install step. 03:38:57 INFO - ##### 03:38:57 INFO - Running pre-action listener: _resource_record_pre_action 03:38:57 INFO - Running main action method: install 03:38:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:58 INFO - Reading from file tmpfile_stdout 03:38:58 INFO - Detecting whether we're running mozinstall >=1.0... 03:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:38:58 INFO - Reading from file tmpfile_stdout 03:38:58 INFO - Output received: 03:38:58 INFO - Usage: mozinstall [options] installer 03:38:58 INFO - Options: 03:38:58 INFO - -h, --help show this help message and exit 03:38:58 INFO - -d DEST, --destination=DEST 03:38:58 INFO - Directory to install application into. [default: 03:38:58 INFO - "/builds/slave/test"] 03:38:58 INFO - --app=APP Application being installed. [default: firefox] 03:38:58 INFO - mkdir: /builds/slave/test/build/application 03:38:58 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'] 03:38:58 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 03:39:12 INFO - Reading from file tmpfile_stdout 03:39:12 INFO - Output received: 03:39:12 INFO - /builds/slave/test/build/application/firefox/firefox 03:39:12 INFO - Running post-action listener: _resource_record_post_action 03:39:12 INFO - ##### 03:39:12 INFO - ##### Running run-tests step. 03:39:12 INFO - ##### 03:39:12 INFO - Running pre-action listener: _resource_record_pre_action 03:39:12 INFO - Running main action method: run_tests 03:39:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:39:12 INFO - Python 2.7.3 03:39:12 INFO - Return code: 0 03:39:12 INFO - grabbing minidump binary from tooltool 03:39:12 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')]} 03:39:12 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 0x2233410>, '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 0x2234310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22347a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:39:12 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 03:39:12 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 03:39:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:39:13 INFO - Return code: 0 03:39:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:39:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:39:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:39:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:39:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:39:13 INFO - Return code: 0 03:39:13 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:39:13 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:39:13 INFO - Using env: {'DISPLAY': ':0', 03:39:13 INFO - 'HOME': '/home/cltbld', 03:39:13 INFO - 'LANG': 'en_US.UTF-8', 03:39:13 INFO - 'LANGUAGE': 'en_US:en', 03:39:13 INFO - 'LOGNAME': 'cltbld', 03:39:13 INFO - 'MAIL': '/var/mail/cltbld', 03:39:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:39:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:13 INFO - 'MOZ_NO_REMOTE': '1', 03:39:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:13 INFO - 'NO_EM_RESTART': '1', 03:39:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:13 INFO - 'PWD': '/builds/slave/test', 03:39:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:39:13 INFO - 'SHELL': '/bin/bash', 03:39:13 INFO - 'SHLVL': '1', 03:39:13 INFO - 'TERM': 'linux', 03:39:13 INFO - 'TMOUT': '86400', 03:39:13 INFO - 'USER': 'cltbld', 03:39:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981', 03:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:13 INFO - '_': '/tools/buildbot/bin/python'} 03:39:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:39:14 INFO - mozversion application_buildid: 20160621002602 03:39:14 INFO - mozversion application_changeset: fb2bd3009fd43b84acffa0eb62151e19c3eb4197 03:39:14 INFO - mozversion application_display_name: Firefox 03:39:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:39:14 INFO - mozversion application_name: Firefox 03:39:14 INFO - mozversion application_remotingname: firefox 03:39:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:39:14 INFO - mozversion application_vendor: Mozilla 03:39:14 INFO - mozversion application_version: 48.0 03:39:14 INFO - mozversion platform_buildid: 20160621002602 03:39:14 INFO - mozversion platform_changeset: fb2bd3009fd43b84acffa0eb62151e19c3eb4197 03:39:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:39:14 INFO - mozversion platform_version: 48.0 03:39:14 INFO - using testdate: 1466505554 03:39:14 INFO - actual date: 1466505554 03:39:14 INFO - starting webserver on 'localhost:46539' 03:39:14 INFO - SUITE-START | Running 2 tests 03:39:14 INFO - TEST-START | dromaeo_css 03:39:14 INFO - operating with platform_type : linux_ 03:39:14 INFO - Initialising browser for dromaeo_css test... 03:39:14 INFO - TEST-INFO | started process 20877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjcsJIU/profile http://localhost:46539/getInfo.html) 03:39:19 INFO - PROCESS | 20877 | __metrics Screen width/height:1600/1200 03:39:19 INFO - PROCESS | 20877 | colorDepth:24 03:39:19 INFO - PROCESS | 20877 | Browser inner width/height: 1024/697 03:39:19 INFO - PROCESS | 20877 | __metrics 03:39:20 ERROR - PROCESS | 20877 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:39:21 INFO - TEST-INFO | 20877: exit 0 03:39:21 INFO - Browser initialized. 03:39:21 INFO - Running cycle 1/1 for dromaeo_css test... 03:39:21 INFO - TEST-INFO | started process 20968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjcsJIU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:33 INFO - PROCESS | 20968 | RSS: Main: 141185024 03:39:33 INFO - PROCESS | 20968 | 03:40:24 INFO - PROCESS | 20968 | 1466505624421 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] 03:42:32 INFO - PROCESS | 20968 | Cycle 1(1): loaded http://localhost:46539/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46539/tests/dromaeo/cssquery-ext.html) 03:42:33 INFO - PROCESS | 20968 | RSS: Main: 245121024 03:42:33 INFO - PROCESS | 20968 | 03:45:35 INFO - PROCESS | 20968 | Cycle 1(1): loaded http://localhost:46539/tests/dromaeo/cssquery-ext.html (next: http://localhost:46539/tests/dromaeo/cssquery-jquery.html) 03:45:36 INFO - PROCESS | 20968 | RSS: Main: 219955200 03:45:36 INFO - PROCESS | 20968 | 03:48:38 INFO - PROCESS | 20968 | Cycle 1(1): loaded http://localhost:46539/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46539/tests/dromaeo/cssquery-mootools.html) 03:48:38 INFO - PROCESS | 20968 | RSS: Main: 216363008 03:48:38 INFO - PROCESS | 20968 | 03:51:40 INFO - PROCESS | 20968 | Cycle 1(1): loaded http://localhost:46539/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46539/tests/dromaeo/cssquery-prototype.html) 03:51:40 INFO - PROCESS | 20968 | RSS: Main: 216686592 03:51:40 INFO - PROCESS | 20968 | 03:54:43 INFO - PROCESS | 20968 | Cycle 1(1): loaded http://localhost:46539/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46539/tests/dromaeo/cssquery-yui.html) 03:54:44 INFO - PROCESS | 20968 | RSS: Main: 182972416 03:54:44 INFO - PROCESS | 20968 | 03:57:46 INFO - PROCESS | 20968 | Cycle 1(1): loaded http://localhost:46539/tests/dromaeo/cssquery-yui.html (next: http://localhost:46539/tests/dromaeo/cssquery-dojo.html) 03:57:46 INFO - PROCESS | 20968 | RSS: Main: 254758912 03:57:46 INFO - PROCESS | 20968 | 03:57:46 INFO - PROCESS | 20968 | __start_tp_report 03:57:46 INFO - PROCESS | 20968 | _x_x_mozilla_page_load 03:57:46 INFO - PROCESS | 20968 | _x_x_mozilla_page_load_details 03:57:46 INFO - PROCESS | 20968 | |i|pagename|runs| 03:57:46 INFO - PROCESS | 20968 | |0;dojo.html;3293.094399040264;3353.698167164956;3358.848851801668;3378.560787097677;3402.965970340297;5593.664380137195;5603.019471592475;5603.467670571299;5610.915836262459;5612.859678508039;5584.692841893694;5633.661980281176;5643.887122257553;5646.915296270559;5648.378678345379;4966.652334336598;5083.339165908436;5166.276721259027;5219.86950326243;5243.606729495284;5058.367704036996;5087.211482220262;5122.92315615266;5123.129068058421;5127.820526281581;5127.820526281562;5181.274621552986;5197.882455272115;5197.922031169535;5238.292830467895;5118.872028199306;5118.897622047575;5133.794648214104;5138.100832354323;5166.535011848933;4973.701577905301;4991.251312303184;5005.424376196711;5031.597472202215;5062.063518249136;5453.100238460649;5509.47659972302;5512.724363781795;5519.475649813261;5523.6685798852195;5969.462748352669;6011.368806275322;6014.849628759316;6017.789377371815;6024.608400453956;5968.731407086648;6045.455908968214;6055.271258845944;6072.605280656743;6074.696265186723;5593.496585307301;5646.604737668365;5653.349864765563;5656.8020119295625;5656.830295091113;5984.790532331434;6127.486424087131;6132.172156758869;6143.201383820075;6153.353897840662;5888.411158884077;5949.8215053548465;5955.255593050869;5963.522918166536;5974.2233509643465;5934.1692163097205;5940.821775346746;5945.672987985702;5947.345791962881;5952;5800.8259752207505;5906.734196961147;5919.6152250103605;5928.822135335947;5929.584929055011;5940.732667029994;5942.70286485674;5963.075723262901;5969.910451343233;5973.820785376359;4557.088582283556;4566.155261276608;4568.109218702321;4577.404937358122;4596.17268891596;4004.0790618157985;4059.7970101494807;4108.938365924513;4119.938200926988;4132.8140233689555;5633.690147041952;5657.066584013592;5659.518940889988;5662.5753068520025;5699.031164702011;5881.941180588139;5926.199963005025;5928.110783382441;5932.881342373128;5946;5558.166275058693;5641.153826925912;5653.604247702704;5718.599698021098;5719.542436605062;5146.819861304836;5152.227165925066;5165.044466773659;5175.767090480937;5196.818111366084;6264.123022776815;6264.498840092781;6285.811425657238;6296.527760417987;6298.842528936813;5904.114382842608;5954.612950158225;6001.159837622824;6045.667488288186;6059.0608455689435;6225.782097626561;6238.189035425366;6258.843528911813;6271.749130034747;6294.968525157345;5868.413158684098;5868.735906884115;5879.029960056543;5879.94120058811;5903;5869.148973398748;5980.730867111078;5998.7300571473515;6070.180525628984;6078.6048906820915;5803.912941305799;5805.970970145122;5839.708014599168;5843.094320380348;5849.473547380756;5771.307443106854;5837.182794408701;5843.678597677169;5844;5848.298204215351;5589.469000444951;5769.826905192851;5809.477147056785;5843.503302219359;5859.560532959959;5896.439838215363;5901.232839730979;5904.3210030847;5922.585419020627;5923.733431995484;5701;5814.04068328721;5824.708764561839;5825.533957283492;5846.152307915413 03:57:46 INFO - PROCESS | 20968 | |1;ext.html;607.2834055814137;662.9966850165748;666.0142988377202;676.9153855768029;678.5792808458756;31319.21701957452;31900;39045;39785.40321895174;39803;41170.7941460293;41834.16331673365;41891.790541047325;41934.58065419352;42151.57848421515;7814.76555703327;8614.784630384227;8779.078196789342;8795;10219.591216351337;10217.080462758351;10342.276040677156;10350.482475876213;10350.844737328945;10363.067323940844;10353.896461035407;10430.530626121843;10430.739231519197;10436.478176091203;10456.634017809378;10281.588736450532;10283.971602839694;10289.948550257239;10311.63909263176;10397.32417392867;10238.129758970497;10347.120494757879;10373.11828494579;10705.197110216764;10722.892771072346;42320;42478;42542.78728606368;42665.786671066446;43047;3791.539588862053;3860.4595356650093;3904.921901561953;3948.4866967294356;3979.064919743887;32701;32908.6709132908;32963;33222;33239.50140747891;4336.804843782037;4349.434573505456;4368.279233926399;4417.050334178167;4468.218061839165;322678;324153;324413;324780;325170;59902.40097599055;60521.39478605158;60927.39072609217;60984;61123;64091.67954160293;69011.3098869015;71302;71314;71372.28627713761;18449;18561.90719046396;18587.81412185861;18591.53521161982;18591.81408185928;13603.183808971493;14349.713005740035;14624.341904614104;14818.259087045604;14841.925790370979;19991.900040499706;19999.500012499513;20007.699884501744;20049.799502005084;20125.899370503346;7123.2520585338825;7243.56732450662;7297.3432391084;7478.962605186939;7581.962090189624;1151.234429104636;1159.287038471351;1172.9560690985031;1175.4122938530734;1253.7555176740448;33478.330433391195;34112.82943585266;34619.653803461646;34750;34829.825850870584;1245.520474617279;1254.9686257843628;1314.7304802515653;1370.7532644123953;1400.2928521096985;17905.7314140288;17940.19269132892;18163.81836181621;18178.727319090223;18234.270629174684;482686;486834;486977;489248;492168;61497;62312;62362.376376235654;62364.688176558826;62420;1497.4534294982252;1515.6968606278567;1516.4464970285767;1533.1337794146273;1615.878809089323;30650.846745766128;31357.686423135478;32385.190370240933;32566;33521;49996;50221.497785023144;50295;50582.24126638177;50590.49409506005;282176;286433;287197;289311;289327;27152.185434436997;30188.84905575458;30568.541471878383;31318;31321.37357252888;44791.776041119585;45064.774676126406;45364.773176135226;46342;47134;37217.5458566739;37232.81383593065;38059.2388152241;38286.42570361391;38707.225855483295;38412.61587384091;38517.80741096276;38534.6146538531;38633;41287.793561032006;41466.37800432936;42136;42751.358729618456;43055.569444305154;43421.56578434175;36176.63823361838;36755;37236.81381593075;37670.62329376781;37988.62011379851;28098.71901280961;28279.657501037655;28626.713732862405;28957.710422895503;30607.387852243275 03:57:46 INFO - PROCESS | 20968 | |2;jquery.html;433.89152711822044;442.79631369569995;446.3750748951468;446.7766116941529;454.8658145846975;18744.2502299908;18949.62100757986;19377.806221937793;20631.896840515816;20680;20048.29830955917;20234.08946597403;20550.588988220265;20554.48613784656;20587.588248235064;5011.448740638536;5278.868028299304;5287.841364759063;5288.0745869472885;5290.2064690296575;3993.5207775067033;4407.625351845097;4922.483139270379;4998.3502144721315;6593.044008618747;6517.543771935966;6543.640099794509;6559.622479279357;6560.803175904706;6562.179727534059;6109.908351374733;6397.10440538325;6414.775482858125;6504.121943537632;6507.739690412378;5649.887002259973;5758.79844205455;5767.625104368202;5780.479756821865;5790.218320526717;14041.859581404158;14286.071405358618;14424.134551926812;14432.855671443256;19102.71345929812;2422.5222614205495;2492.6385674077337;2502.2993561802723;2557.9104731334314;2561.5389229938605;10401.323913945645;10588.100011499031;10827.133829293638;13885.583432497042;14575.833933285312;2054.4658388819016;2060.701198326234;2124.5432232070025;2127.6808378805085;2130.4141361125658;62606.68696656533;64559.67720161369;65019.34980650227;69798.95301570531;73072.63463682648;10989.835152472719;11239.325640461599;11295.209335346446;11481.311121332747;11584.131190160602;15963.680726385408;16082.43711470093;16107.516774496784;16128.919355403383;16141.67716645684;8874.979377371556;8992.460452372748;9007.684731034382;9031.683891063782;9073.95463022694;8912.55437228136;8965.417247878868;8980.236679882153;9188.310876684276;9225.769355766026;4606.608438282784;4829.227323628203;5003.924941125886;5008.098542262428;5216.087184742655;2070.3788863340937;2075.2010475966863;2109.862858914166;2118.2691971269887;2161.9891900540397;990.3117333453181;996.272720913737;1039.0804138337626;1097.2154909239932;1162.604714397109;11989.22070065443;18984.240630374905;19035.238590456225;19178.520536986685;19603.411897643095;518.2795913679988;520.8671788693858;526.1134987545921;526.468267050282;530.7266757619828;6099.329073801879;6890.138732658418;6895.103636527319;6930.965345173343;6966.3730264276455;521066;547208;563095;573515;584883;93523.53238233765;95416;96270.51864740772;98194.50902745583;99718.5014074925;509.9031184075014;535.2773755430138;537.7123239067158;557.4926816596958;560.28563581434;11498.310101393943;11619.302841829518;11643.88356116428;11700.824487632523;11886.881131188924;35978.64021359753;36558.63441365552;37365;37924.62075379211;38389.99999999888;55272.72363638317;55776.72111639416;55822;56118.43881561132;56383.43616563782;9301.069893010645;9343.112404321579;9498.335116541775;9511.557869123846;9538.14156725898;13252.20486770797;14222.573322799919;14296.428142874169;14480.710385792014;14493.492727754478;12271.877281227431;12322.507099715911;12325.50697972071;12363.505459781509;12613.243205407705;12240.69398265015;12313.458943475292;12386.504539818307;12404.379781011094;12442.937785311378;12331.630051098482;12496.687582810502;12573.874261257637;12757.362131893182;12762.29807360604;9219.262459003397;9408.858867116862;9414.905850941403;9453.385529940531;9473.100055494717;9512.95243523778;11255.7748845021;11879.109066820196;11917.22538035025;12270.509179632714 03:57:46 INFO - PROCESS | 20968 | |3;mootools.html;1393.2824595333398;1558;1562.9062256264624;1773.6807374672553;1928.5949950510392;7066.929330706691;7920.485168464046;8060.193980601937;8065.395095367841;8069.273765361117;7736.574488403136;7884.96057519713;7889.566073865935;7905.604719764017;7906.762797116081;2418.504206637644;2424.200013995386;2441.084593277521;2444.095684596693;2448.8897999590063;2327.8836058197107;2382.2376839411395;2383.630537266718;2390.6414037894283;2401.1955994741784;2437.792787613055;2451.1175976648483;2456.9262922112275;2490.140901389027;2493.9376515587073;2408.0969636386353;2445.7065152181676;2458.409981604411;2465.0139944022444;2465.765752253542;2337.953240935172;2400.2079313826393;2407.6749638798715;2407.879606019692;2410.5660981023407;7012.123484564429;7737.535747855147;8103.2707056364625;8154.633041513146;8163.918360816375;5149.356330458692;5240.056789777838;5280.788768449257;5290.55030322423;5293.497117773805;3477.4609935460044;3485.825708714554;3544.3088597723454;3597.406427939387;3599.982000090009;1118.6420345489446;1179.351356753782;1185.7213554814698;1200.5413422691472;1213.2599114540124;11058.612948546843;11368.60209892658;11402.71493212668;11441.141914356373;11464.770704585862;4657.371254880615;4683.461401938753;4739.739314337676;4753.382060332204;4758.857234282977;9866.358686685342;9889.75275618101;9903.158231550398;9904.653337133166;9917.553710083064;5343.893122137535;5349.331333583302;5349.625526213205;5355.812546560852;5355.839324820184;4827.61379089672;4877.829275975395;4881.633877459134;4890.804367825247;4899.706017638953;3743.5320584926885;3799.0312470320446;3827.483289755903;3857.556381016163;3862.4592557042038;1150.9482073306722;1156.8380426740264;1165.120334147713;1177.6584790410684;1180.5867946218755;923.5890028937193;1026.707388394304;1039.6309310194922;1040.422565476168;1040.6929955663097;5603.187537806995;5717.142428635655;5736.282964629421;5809.0124678804705;5827.562932779973;1033.751899544104;1034.5809946971488;1039.2205845615788;1044.8223801953534;1061.098066643347;3411.1642647551507;3921.039345360348;4024.9798751006642;4058.6955978301744;4079.714419990572;9475.052494750607;10204.132648724793;10355.223358248162;10360.585576576852;10392.116670083127;10209.183265338903;10225.539850706737;10232.232582556338;10253.128484078938;10266.435346056038;7620.657070431844;7693.038370203724;7770.728024519115;7792.649330780128;7802.843943121105;5463.808766693147;5469.644473109394;5504.724763761876;5573.164025396223;5691.971540142273;8883.37816352849;8941.776455588662;8942.776430589287;8964.32767542424;9012;8774.254188394058;8948.910510894808;8951.597178126869;9116.726498205064;9120;7393.186749457663;7425.554466732014;7467.253274672489;7475.36459400957;7510.586917719578;7853.410994175574;7900.960495197487;7903.960480197792;7910.169432209535;7911.564863932539;6956.234814170336;7048.365647091787;7120.252373500915;7360.705571777069;7464.813379665552;7106.857862842611;7151.106111736033;7235.131784185932;7260.96369518149;7270;6724.058631791651;6832.453403727789;6840.076589660531;6860.382565569123;6873.48448866347;5177.611679124006;5184.818531351385;5209.426963033988;5228.7647055883335;5241.213817927189;4267.80794864238;4973.204287314013;5087.414947280962;5167.58659307247;5213.296205012275 03:57:46 INFO - PROCESS | 20968 | |4;prototype.html;354.11647938393696;360.64476490656705;361.2413930745435;376.5124164207353;377.68085967357575;6122.9387706122925;6272.4041216084515;6286.057091436282;6288.434040936315;6361.363863613637;5941.197938278331;6019.668918209497;6207.348228436017;6214.440700336969;6243.937560624404;4795.0889331027165;4831.6859404138795;4831.7584120794;4833.589144922686;4846.68496547725;4790.329353890458;4837.32277481153;4855.878603034935;4856.5629093381585;4862.6109911207195;4558;4679.251319788835;4685.5548722871445;4805.20714082176;4809.855704328858;4776.785044672998;4777.498362671921;4783.784729687138;4786.928196077061;4791.736454495001;4232.365145228209;4236;4238.321868501056;4241.936370954438;4244.363345498169;6021.427964343424;6024.638521688669;6031.306399764039;6034.456898879078;6038.456538911519;5564.137558678412;5572.275604171432;5579.748911298961;5580.162975553659;5581.5813813963705;6423.261324947644;6557.967210163919;6563.278039415661;6565.507586930951;6570.342965703391;4662.976685116587;4692.718436893797;4696.506866779007;4700.365450664151;4701.694389864648;6736.427403670694;6799.456043516507;6823.55646882951;6834.316568343126;6838.829029274259;4789.425268967746;4821.2045012572535;4821.276808478756;4824.421069471616;4825.252085926687;4870.975645121752;4871.853844384604;4875.926861097087;4881.658283920163;4882.145624515695;5196.558292545101;5372.7582258797665;5431.131019036935;5543.307086614173;5554.1946417769195;6556.246031706415;6573.276939536647;6573.506986975996;6581.868362632817;6592.868142637216;1568.3021055630363;1616.2161351744394;1631.7797097391938;1640.6882692288666;1641.4172968596215;1089.8583184186004;1110.5280255891375;1111.216592302425;1115.3865374044244;1125.5047778977223;6351.491880649537;6357.396047375492;6357.936420635734;6361.713722882481;6366.618002919747;6704.296048914891;6704.363085506869;6708.698108585126;6718.428933540704;6723.294054124344;6339;6343.746250150035;6345.079963405373;6350.7777227796805;6351.904721429182;3587.9641203588153;3609.7112231021456;3615.0420138663276;3626.5648122225502;3628.38317486028;6857.588544687334;7051.964740176369;7184.209736928934;7192.640367981685;7206.711731530785;6926.341997510229;6936.132983377078;6940.479464040217;6940.930590694129;6951.339622735832;7128.572285662877;7145.249748776408;7161.319674630901;7178.712851485987;7179.138503379523;6825.965870170618;6841.281665425257;6861.4853885957755;6884.862302754017;6910.101686780687;6462.289148193601;6674.499412544175;6724.899126513008;6730.293319201413;6734.057231987427;7048.506604537633;7072.504924655431;7138.785836424916;7156.928430715626;7157.57054576727;4647.628189744744;4681.461631912373;4695.694779839299;4696.647751418589;4699.976500117477;6541.34586541342;6797.72809087631;6804.863902722017;6808.285130061272;6818.795436136924;6401.231852177769;6493.8701225976165;6495.1556297681;6603.636799976048;6643.269240383651;6517.967410162919;6579.243387010555;6589.110470086669;6598.406143447113;6604.108445359815;6487.578307410004;6492.48060155177;6497.740090396331;6502.0246962955935;6503.089567460654;6547.1161393213215;6590.439812615981;6608.471322294301;6648.83377915556;6658.400743932875;6458.225012998282;6495.512836537373;6496.7726129585235;6497.805065848032;6509.576877502947 03:57:46 INFO - PROCESS | 20968 | |5;yui.html;761.5697131120917;839.7774589733725;884.6019291318906;891.7369376034071;917.4128557723054;15741.921290393546;15891.761623575627;15952.601184970381;17031.318747250094;17483.475495735118;15997.920010399961;16121.355145794154;16130.83869161311;16213.594660133502;16214;760.3536993555489;906.9093090690944;913.8720579118929;926.8146370725848;927.638221093774;924.685606893656;925.6436272035281;927.6057675487891;929.6746138851382;929.8000929800091;783.5024759277871;962.3600305796637;962.7256231973889;962.8363178259677;968.3366893677818;787.7282337593521;949.1742184299669;956.7751578379075;958.750724811547;958.9232861371108;697.4873468001015;701.8175274428635;705.3334598804132;706.9505134640577;712.6721708014268;15340.079595224322;15355.232238388036;15386.615334616612;15432.151231682254;15459.613509662237;13888.930555347159;14218;14422.206778627276;14432.494862679756;14480.710385792225;12466.937665311707;12580.622581322576;12601.810972835416;12650.240985540897;12728.363581820871;4034.9193016139807;4138.503379594438;4139.544650088488;4161.854335098287;4177.143685544456;54473.1829022565;55519.16721249185;55707;55900.44099559034;62150.378496215366;11676.241044332091;11815.232009919328;11974.22167559106;12073.818892716616;12204;20887.164513419597;20923.163073477193;20955.790442095687;20973.47566310824;20994.160233590486;9000.729978100668;9049.276057915351;9088.04575519574;9145.314101442418;9148.176664100263;5067.923981140286;5125.666831656005;5163.277141200235;5201.843944681666;5234.18870075139;3484.26830365621;3486.389881770731;3533.5406397168204;3545.2023294758474;3546.255286389887;620.8385819686914;684.4045680258207;714.8705046027368;724.9746258880914;731.7146312937958;706.1561434086218;785.9724909628136;800.6757263308369;819.6393586821779;842.8819965204754;9828.655997040069;9838.950805245928;9949.353292035994;9980.650677226262;10193.745156371002;708.6563016936782;832.9541875196801;838.6729175621513;840.3193413335218;856.9228769410782;4572.81708731647;4589.35748995141;4701.48283688794;4715.528447155257;4757.333973243749;61714;62278.37721622817;62506.37493625005;62606.37393626096;62698.37301626925;58958.70520647455;59942.40057599456;60776;60792;60934;52630.21054684183;53325.73337133367;53446.732766336696;54118.18822717662;54187;8996.190342869173;8998.910010899806;9074.909250907407;9140.6800761973;9317.11487408695;38507.42238866475;39498.40752388659;39853.601463986146;40012.1997560053;40270.39594406028;46160;46277.537224627325;51515;51750.223746643074;52240.73879630578;11922.403879806148;11960;12015.459304331502;12129.9083082523;12338;12768.936155319536;12922;13620.386205108629;14284.57146285613;14552.41790328375;13434.395452204479;13442.663933401744;13802.792958105838;13894.166350019032;14464.20446875432;13538.187708737507;13634.454621815017;13819.378127984466;13828.239446830119;14004.929975350058;12969.286689232184;13060.80408793888;13258.071934964846;13375.130616509896;13931.373088211258;11137.665870023913;11439.828402573801;11533.480993355151;11541.596044138414;11721.12091593151;11181.608643697431;11259.79290395889;11602.18784685064;11632.88367116318;11671.941640291745 03:57:46 INFO - PROCESS | 20968 | __end_tp_report 03:57:46 INFO - PROCESS | 20968 | __start_cc_report 03:57:46 INFO - PROCESS | 20968 | _x_x_mozilla_cycle_collect,831 03:57:46 INFO - PROCESS | 20968 | __end_cc_report 03:57:46 INFO - PROCESS | 20968 | __startTimestamp1466506666733__endTimestamp 03:57:46 INFO - PROCESS | 20968 | 03:57:46 INFO - PROCESS | 20968 | ------- Summary: start ------- 03:57:46 INFO - PROCESS | 20968 | Number of tests: 6 03:57:46 INFO - PROCESS | 20968 | 03:57:46 INFO - PROCESS | 20968 | [#0] dojo.html Cycles:165 Average:5571.05 Median:5809.48 stddev:618.51 (10.6%) stddev-sans-first:594.03 03:57:46 INFO - PROCESS | 20968 | Values: 3293.1 3353.7 3358.8 3378.6 3403.0 5593.7 5603.0 5603.5 5610.9 5612.9 5584.7 5633.7 5643.9 5646.9 5648.4 4966.7 5083.3 5166.3 5219.9 5243.6 5058.4 5087.2 5122.9 5123.1 5127.8 5127.8 5181.3 5197.9 5197.9 5238.3 5118.9 5118.9 5133.8 5138.1 5166.5 4973.7 4991.3 5005.4 5031.6 5062.1 5453.1 5509.5 5512.7 5519.5 5523.7 5969.5 6011.4 6014.8 6017.8 6024.6 5968.7 6045.5 6055.3 6072.6 6074.7 5593.5 5646.6 5653.3 5656.8 5656.8 5984.8 6127.5 6132.2 6143.2 6153.4 5888.4 5949.8 5955.3 5963.5 5974.2 5934.2 5940.8 5945.7 5947.3 5952.0 5800.8 5906.7 5919.6 5928.8 5929.6 5940.7 5942.7 5963.1 5969.9 5973.8 4557.1 4566.2 4568.1 4577.4 4596.2 4004.1 4059.8 4108.9 4119.9 4132.8 5633.7 5657.1 5659.5 5662.6 5699.0 5881.9 5926.2 5928.1 5932.9 5946.0 5558.2 5641.2 5653.6 5718.6 5719.5 5146.8 5152.2 5165.0 5175.8 5196.8 6264.1 6264.5 6285.8 6296.5 6298.8 5904.1 5954.6 6001.2 6045.7 6059.1 6225.8 6238.2 6258.8 6271.7 6295.0 5868.4 5868.7 5879.0 5879.9 5903.0 5869.1 5980.7 5998.7 6070.2 6078.6 5803.9 5806.0 5839.7 5843.1 5849.5 5771.3 5837.2 5843.7 5844.0 5848.3 5589.5 5769.8 5809.5 5843.5 5859.6 5896.4 5901.2 5904.3 5922.6 5923.7 5701.0 5814.0 5824.7 5825.5 5846.2 03:57:46 INFO - PROCESS | 20968 | 03:57:46 INFO - PROCESS | 20968 | [#1] ext.html Cycles:180 Average:54580.24 Median:34684.83 stddev:99291.42 (286.3%) stddev-sans-first:99487.26 03:57:46 INFO - PROCESS | 20968 | Values: 607.3 663.0 666.0 676.9 678.6 31319.2 31900.0 39045.0 39785.4 39803.0 41170.8 41834.2 41891.8 41934.6 42151.6 7814.8 8614.8 8779.1 8795.0 10219.6 10217.1 10342.3 10350.5 10350.8 10363.1 10353.9 10430.5 10430.7 10436.5 10456.6 10281.6 10284.0 10289.9 10311.6 10397.3 10238.1 10347.1 10373.1 10705.2 10722.9 42320.0 42478.0 42542.8 42665.8 43047.0 3791.5 3860.5 3904.9 3948.5 3979.1 32701.0 32908.7 32963.0 33222.0 33239.5 4336.8 4349.4 4368.3 4417.1 4468.2 322678.0 324153.0 324413.0 324780.0 325170.0 59902.4 60521.4 60927.4 60984.0 61123.0 64091.7 69011.3 71302.0 71314.0 71372.3 18449.0 18561.9 18587.8 18591.5 18591.8 13603.2 14349.7 14624.3 14818.3 14841.9 19991.9 19999.5 20007.7 20049.8 20125.9 7123.3 7243.6 7297.3 7479.0 7582.0 1151.2 1159.3 1173.0 1175.4 1253.8 33478.3 34112.8 34619.7 34750.0 34829.8 1245.5 1255.0 1314.7 1370.8 1400.3 17905.7 17940.2 18163.8 18178.7 18234.3 482686.0 486834.0 486977.0 489248.0 492168.0 61497.0 62312.0 62362.4 62364.7 62420.0 1497.5 1515.7 1516.4 1533.1 1615.9 30650.8 31357.7 32385.2 32566.0 33521.0 49996.0 50221.5 50295.0 50582.2 50590.5 282176.0 286433.0 287197.0 289311.0 289327.0 27152.2 30188.8 30568.5 31318.0 31321.4 44791.8 45064.8 45364.8 46342.0 47134.0 37217.5 37232.8 38059.2 38286.4 38707.2 38412.6 38517.8 38534.6 38633.0 41287.8 41466.4 42136.0 42751.4 43055.6 43421.6 36176.6 36755.0 37236.8 37670.6 37988.6 28098.7 28279.7 28626.7 28957.7 30607.4 03:57:46 INFO - PROCESS | 20968 | 03:57:46 INFO - PROCESS | 20968 | [#2] jquery.html Cycles:180 Average:30236.46 Median:444.59 stddev:91645.01 (20613.6%) stddev-sans-first:91874.77 03:57:46 INFO - PROCESS | 20968 | Values: 433.9 442.8 446.4 446.8 454.9 18744.3 18949.6 19377.8 20631.9 20680.0 20048.3 20234.1 20550.6 20554.5 20587.6 5011.4 5278.9 5287.8 5288.1 5290.2 3993.5 4407.6 4922.5 4998.4 6593.0 6517.5 6543.6 6559.6 6560.8 6562.2 6109.9 6397.1 6414.8 6504.1 6507.7 5649.9 5758.8 5767.6 5780.5 5790.2 14041.9 14286.1 14424.1 14432.9 19102.7 2422.5 2492.6 2502.3 2557.9 2561.5 10401.3 10588.1 10827.1 13885.6 14575.8 2054.5 2060.7 2124.5 2127.7 2130.4 62606.7 64559.7 65019.3 69799.0 73072.6 10989.8 11239.3 11295.2 11481.3 11584.1 15963.7 16082.4 16107.5 16128.9 16141.7 8875.0 8992.5 9007.7 9031.7 9074.0 8912.6 8965.4 8980.2 9188.3 9225.8 4606.6 4829.2 5003.9 5008.1 5216.1 2070.4 2075.2 2109.9 2118.3 2162.0 990.3 996.3 1039.1 1097.2 1162.6 11989.2 18984.2 19035.2 19178.5 19603.4 518.3 520.9 526.1 526.5 530.7 6099.3 6890.1 6895.1 6931.0 6966.4 521066.0 547208.0 563095.0 573515.0 584883.0 93523.5 95416.0 96270.5 98194.5 99718.5 509.9 535.3 537.7 557.5 560.3 11498.3 11619.3 11643.9 11700.8 11886.9 35978.6 36558.6 37365.0 37924.6 38390.0 55272.7 55776.7 55822.0 56118.4 56383.4 9301.1 9343.1 9498.3 9511.6 9538.1 13252.2 14222.6 14296.4 14480.7 14493.5 12271.9 12322.5 12325.5 12363.5 12613.2 12240.7 12313.5 12386.5 12404.4 12442.9 12331.6 12496.7 12573.9 12757.4 12762.3 9219.3 9408.9 9414.9 9453.4 9473.1 9513.0 11255.8 11879.1 11917.2 12270.5 03:57:46 INFO - PROCESS | 20968 | 03:57:46 INFO - PROCESS | 20968 | [#3] mootools.html Cycles:180 Average:5512.82 Median:5118.39 stddev:2949.54 (57.6%) stddev-sans-first:2941.56 03:57:46 INFO - PROCESS | 20968 | Values: 1393.3 1558.0 1562.9 1773.7 1928.6 7066.9 7920.5 8060.2 8065.4 8069.3 7736.6 7885.0 7889.6 7905.6 7906.8 2418.5 2424.2 2441.1 2444.1 2448.9 2327.9 2382.2 2383.6 2390.6 2401.2 2437.8 2451.1 2456.9 2490.1 2493.9 2408.1 2445.7 2458.4 2465.0 2465.8 2338.0 2400.2 2407.7 2407.9 2410.6 7012.1 7737.5 8103.3 8154.6 8163.9 5149.4 5240.1 5280.8 5290.6 5293.5 3477.5 3485.8 3544.3 3597.4 3600.0 1118.6 1179.4 1185.7 1200.5 1213.3 11058.6 11368.6 11402.7 11441.1 11464.8 4657.4 4683.5 4739.7 4753.4 4758.9 9866.4 9889.8 9903.2 9904.7 9917.6 5343.9 5349.3 5349.6 5355.8 5355.8 4827.6 4877.8 4881.6 4890.8 4899.7 3743.5 3799.0 3827.5 3857.6 3862.5 1150.9 1156.8 1165.1 1177.7 1180.6 923.6 1026.7 1039.6 1040.4 1040.7 5603.2 5717.1 5736.3 5809.0 5827.6 1033.8 1034.6 1039.2 1044.8 1061.1 3411.2 3921.0 4025.0 4058.7 4079.7 9475.1 10204.1 10355.2 10360.6 10392.1 10209.2 10225.5 10232.2 10253.1 10266.4 7620.7 7693.0 7770.7 7792.6 7802.8 5463.8 5469.6 5504.7 5573.2 5692.0 8883.4 8941.8 8942.8 8964.3 9012.0 8774.3 8948.9 8951.6 9116.7 9120.0 7393.2 7425.6 7467.3 7475.4 7510.6 7853.4 7901.0 7904.0 7910.2 7911.6 6956.2 7048.4 7120.3 7360.7 7464.8 7106.9 7151.1 7235.1 7261.0 7270.0 6724.1 6832.5 6840.1 6860.4 6873.5 5177.6 5184.8 5209.4 5228.8 5241.2 4267.8 4973.2 5087.4 5167.6 5213.3 03:57:46 INFO - PROCESS | 20968 | 03:57:46 INFO - PROCESS | 20968 | [#4] prototype.html Cycles:180 Average:5534.08 Median:6344.41 stddev:1658.22 (26.1%) stddev-sans-first:1616.65 03:57:46 INFO - PROCESS | 20968 | Values: 354.1 360.6 361.2 376.5 377.7 6122.9 6272.4 6286.1 6288.4 6361.4 5941.2 6019.7 6207.3 6214.4 6243.9 4795.1 4831.7 4831.8 4833.6 4846.7 4790.3 4837.3 4855.9 4856.6 4862.6 4558.0 4679.3 4685.6 4805.2 4809.9 4776.8 4777.5 4783.8 4786.9 4791.7 4232.4 4236.0 4238.3 4241.9 4244.4 6021.4 6024.6 6031.3 6034.5 6038.5 5564.1 5572.3 5579.7 5580.2 5581.6 6423.3 6558.0 6563.3 6565.5 6570.3 4663.0 4692.7 4696.5 4700.4 4701.7 6736.4 6799.5 6823.6 6834.3 6838.8 4789.4 4821.2 4821.3 4824.4 4825.3 4871.0 4871.9 4875.9 4881.7 4882.1 5196.6 5372.8 5431.1 5543.3 5554.2 6556.2 6573.3 6573.5 6581.9 6592.9 1568.3 1616.2 1631.8 1640.7 1641.4 1089.9 1110.5 1111.2 1115.4 1125.5 6351.5 6357.4 6357.9 6361.7 6366.6 6704.3 6704.4 6708.7 6718.4 6723.3 6339.0 6343.7 6345.1 6350.8 6351.9 3588.0 3609.7 3615.0 3626.6 3628.4 6857.6 7052.0 7184.2 7192.6 7206.7 6926.3 6936.1 6940.5 6940.9 6951.3 7128.6 7145.2 7161.3 7178.7 7179.1 6826.0 6841.3 6861.5 6884.9 6910.1 6462.3 6674.5 6724.9 6730.3 6734.1 7048.5 7072.5 7138.8 7156.9 7157.6 4647.6 4681.5 4695.7 4696.6 4700.0 6541.3 6797.7 6804.9 6808.3 6818.8 6401.2 6493.9 6495.2 6603.6 6643.3 6518.0 6579.2 6589.1 6598.4 6604.1 6487.6 6492.5 6497.7 6502.0 6503.1 6547.1 6590.4 6608.5 6648.8 6658.4 6458.2 6495.5 6496.8 6497.8 6509.6 03:57:46 INFO - PROCESS | 20968 | 03:57:46 INFO - PROCESS | 20968 | [#5] yui.html Cycles:180 Average:15905.14 Median:4708.51 stddev:18126.71 (385.0%) stddev-sans-first:18141.88 03:57:46 INFO - PROCESS | 20968 | Values: 761.6 839.8 884.6 891.7 917.4 15741.9 15891.8 15952.6 17031.3 17483.5 15997.9 16121.4 16130.8 16213.6 16214.0 760.4 906.9 913.9 926.8 927.6 924.7 925.6 927.6 929.7 929.8 783.5 962.4 962.7 962.8 968.3 787.7 949.2 956.8 958.8 958.9 697.5 701.8 705.3 707.0 712.7 15340.1 15355.2 15386.6 15432.2 15459.6 13888.9 14218.0 14422.2 14432.5 14480.7 12466.9 12580.6 12601.8 12650.2 12728.4 4034.9 4138.5 4139.5 4161.9 4177.1 54473.2 55519.2 55707.0 55900.4 62150.4 11676.2 11815.2 11974.2 12073.8 12204.0 20887.2 20923.2 20955.8 20973.5 20994.2 9000.7 9049.3 9088.0 9145.3 9148.2 5067.9 5125.7 5163.3 5201.8 5234.2 3484.3 3486.4 3533.5 3545.2 3546.3 620.8 684.4 714.9 725.0 731.7 706.2 786.0 800.7 819.6 842.9 9828.7 9839.0 9949.4 9980.7 10193.7 708.7 833.0 838.7 840.3 856.9 4572.8 4589.4 4701.5 4715.5 4757.3 61714.0 62278.4 62506.4 62606.4 62698.4 58958.7 59942.4 60776.0 60792.0 60934.0 52630.2 53325.7 53446.7 54118.2 54187.0 8996.2 8998.9 9074.9 9140.7 9317.1 38507.4 39498.4 39853.6 40012.2 40270.4 46160.0 46277.5 51515.0 51750.2 52240.7 11922.4 11960.0 12015.5 12129.9 12338.0 12768.9 12922.0 13620.4 14284.6 14552.4 13434.4 13442.7 13802.8 13894.2 14464.2 13538.2 13634.5 13819.4 13828.2 14004.9 12969.3 13060.8 13258.1 13375.1 13931.4 11137.7 11439.8 11533.5 11541.6 11721.1 11181.6 11259.8 11602.2 11632.9 11671.9 03:57:46 INFO - PROCESS | 20968 | -------- Summary: end -------- 03:57:46 INFO - PROCESS | 20968 | 03:57:47 INFO - TEST-INFO | 20968: exit 0 03:57:47 INFO - TEST-OK | dromaeo_css | took 1113258ms 03:57:47 INFO - TEST-START | kraken 03:57:47 INFO - operating with platform_type : linux_ 03:57:47 INFO - Initialising browser for kraken test... 03:57:47 INFO - TEST-INFO | started process 21162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcvPKKa/profile http://localhost:46539/getInfo.html) 03:57:52 INFO - PROCESS | 21162 | __metrics Screen width/height:1600/1200 03:57:52 INFO - PROCESS | 21162 | colorDepth:24 03:57:52 INFO - PROCESS | 21162 | Browser inner width/height: 1024/697 03:57:52 INFO - PROCESS | 21162 | __metrics 03:57:53 ERROR - PROCESS | 21162 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:57:54 INFO - TEST-INFO | 21162: exit 0 03:57:54 INFO - Browser initialized. 03:57:54 INFO - Running cycle 1/1 for kraken test... 03:57:54 INFO - TEST-INFO | started process 21250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcvPKKa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:05 INFO - PROCESS | 21250 | RSS: Main: 141291520 03:58:05 INFO - PROCESS | 21250 | 03:58:08 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46539/tests/kraken/driver.html?testName=audio-beat-detection) 03:58:09 INFO - PROCESS | 21250 | RSS: Main: 197771264 03:58:09 INFO - PROCESS | 21250 | 03:58:11 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46539/tests/kraken/driver.html?testName=audio-dft) 03:58:12 INFO - PROCESS | 21250 | RSS: Main: 185241600 03:58:12 INFO - PROCESS | 21250 | 03:58:15 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46539/tests/kraken/driver.html?testName=audio-fft) 03:58:15 INFO - PROCESS | 21250 | RSS: Main: 274157568 03:58:15 INFO - PROCESS | 21250 | 03:58:17 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46539/tests/kraken/driver.html?testName=audio-oscillator) 03:58:18 INFO - PROCESS | 21250 | RSS: Main: 180924416 03:58:18 INFO - PROCESS | 21250 | 03:58:20 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46539/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:58:21 INFO - PROCESS | 21250 | RSS: Main: 178388992 03:58:21 INFO - PROCESS | 21250 | 03:58:24 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46539/tests/kraken/driver.html?testName=imaging-darkroom) 03:58:24 INFO - PROCESS | 21250 | RSS: Main: 213426176 03:58:24 INFO - PROCESS | 21250 | 03:58:28 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46539/tests/kraken/driver.html?testName=imaging-desaturate) 03:58:28 INFO - PROCESS | 21250 | RSS: Main: 212602880 03:58:28 INFO - PROCESS | 21250 | 03:58:31 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46539/tests/kraken/driver.html?testName=json-parse-financial) 03:58:31 INFO - PROCESS | 21250 | RSS: Main: 212856832 03:58:31 INFO - PROCESS | 21250 | 03:58:33 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46539/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:58:34 INFO - PROCESS | 21250 | RSS: Main: 195076096 03:58:34 INFO - PROCESS | 21250 | 03:58:35 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46539/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:58:36 INFO - PROCESS | 21250 | RSS: Main: 198610944 03:58:36 INFO - PROCESS | 21250 | 03:58:38 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46539/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:58:39 INFO - PROCESS | 21250 | RSS: Main: 207949824 03:58:39 INFO - PROCESS | 21250 | 03:58:41 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:58:41 INFO - PROCESS | 21250 | RSS: Main: 217006080 03:58:41 INFO - PROCESS | 21250 | 03:58:44 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:58:45 INFO - PROCESS | 21250 | RSS: Main: 213434368 03:58:45 INFO - PROCESS | 21250 | 03:58:46 INFO - PROCESS | 21250 | Cycle 1(1): loaded http://localhost:46539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46539/tests/kraken/driver.html?testName=ai-astar) 03:58:47 INFO - PROCESS | 21250 | RSS: Main: 273776640 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | __start_tp_report 03:58:47 INFO - PROCESS | 21250 | _x_x_mozilla_page_load 03:58:47 INFO - PROCESS | 21250 | _x_x_mozilla_page_load_details 03:58:47 INFO - PROCESS | 21250 | |i|pagename|runs| 03:58:47 INFO - PROCESS | 21250 | |0;ai-astar;111;111;111;110;111;112;105;110;110;109 03:58:47 INFO - PROCESS | 21250 | |1;audio-beat-detection;156;131;154;184;128;157;153;127;183;126 03:58:47 INFO - PROCESS | 21250 | |2;audio-dft;161;160;162;162;161;161;161;160;161;160 03:58:47 INFO - PROCESS | 21250 | |3;audio-fft;76;75;76;181;76;76;74;77;172;76 03:58:47 INFO - PROCESS | 21250 | |4;audio-oscillator;92;92;149;92;94;93;155;93;92;154 03:58:47 INFO - PROCESS | 21250 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;116;116;116 03:58:47 INFO - PROCESS | 21250 | |6;imaging-darkroom;145;146;146;145;146;146;145;145;146;147 03:58:47 INFO - PROCESS | 21250 | |7;imaging-desaturate;95;94;95;95;94;94;94;94;94;94 03:58:47 INFO - PROCESS | 21250 | |8;json-parse-financial;54;53;53;53;55;54;53;69;51;52 03:58:47 INFO - PROCESS | 21250 | |9;json-stringify-tinderbox;58;60;65;58;58;59;57;57;62;58 03:58:47 INFO - PROCESS | 21250 | |10;stanford-crypto-aes;73;72;71;76;81;73;73;73;74;73 03:58:47 INFO - PROCESS | 21250 | |11;stanford-crypto-ccm;116;116;114;116;109;115;120;112;129;126 03:58:47 INFO - PROCESS | 21250 | |12;stanford-crypto-pbkdf2;159;163;157;159;158;159;158;166;164;157 03:58:47 INFO - PROCESS | 21250 | |13;stanford-crypto-sha256-iterative;68;66;67;67;69;67;66;66;67;66 03:58:47 INFO - PROCESS | 21250 | __end_tp_report 03:58:47 INFO - PROCESS | 21250 | __start_cc_report 03:58:47 INFO - PROCESS | 21250 | _x_x_mozilla_cycle_collect,1586 03:58:47 INFO - PROCESS | 21250 | __end_cc_report 03:58:47 INFO - PROCESS | 21250 | __startTimestamp1466506727217__endTimestamp 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | ------- Summary: start ------- 03:58:47 INFO - PROCESS | 21250 | Number of tests: 14 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.94 (1.8%) stddev-sans-first:2.03 03:58:47 INFO - PROCESS | 21250 | Values: 111.0 111.0 111.0 110.0 111.0 112.0 105.0 110.0 110.0 109.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:155.00 stddev:21.87 (14.1%) stddev-sans-first:23.09 03:58:47 INFO - PROCESS | 21250 | Values: 156.0 131.0 154.0 184.0 128.0 157.0 153.0 127.0 183.0 126.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:58:47 INFO - PROCESS | 21250 | Values: 161.0 160.0 162.0 162.0 161.0 161.0 161.0 160.0 161.0 160.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#3] audio-fft Cycles:10 Average:95.90 Median:76.00 stddev:42.54 (56.0%) stddev-sans-first:44.51 03:58:47 INFO - PROCESS | 21250 | Values: 76.0 75.0 76.0 181.0 76.0 76.0 74.0 77.0 172.0 76.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:92.00 stddev:29.08 (31.6%) stddev-sans-first:30.05 03:58:47 INFO - PROCESS | 21250 | Values: 92.0 92.0 149.0 92.0 94.0 93.0 155.0 93.0 92.0 154.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:58:47 INFO - PROCESS | 21250 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 03:58:47 INFO - PROCESS | 21250 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 147.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:58:47 INFO - PROCESS | 21250 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:53.50 stddev:5.14 (9.6%) stddev-sans-first:5.45 03:58:47 INFO - PROCESS | 21250 | Values: 54.0 53.0 53.0 53.0 55.0 54.0 53.0 69.0 51.0 52.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:58.50 stddev:2.53 (4.3%) stddev-sans-first:2.65 03:58:47 INFO - PROCESS | 21250 | Values: 58.0 60.0 65.0 58.0 58.0 59.0 57.0 57.0 62.0 58.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.00 stddev:2.81 (3.8%) stddev-sans-first:2.96 03:58:47 INFO - PROCESS | 21250 | Values: 73.0 72.0 71.0 76.0 81.0 73.0 73.0 73.0 74.0 73.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:116.00 stddev:6.13 (5.3%) stddev-sans-first:6.48 03:58:47 INFO - PROCESS | 21250 | Values: 116.0 116.0 114.0 116.0 109.0 115.0 120.0 112.0 129.0 126.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:159.00 stddev:3.16 (2.0%) stddev-sans-first:3.33 03:58:47 INFO - PROCESS | 21250 | Values: 159.0 163.0 157.0 159.0 158.0 159.0 158.0 166.0 164.0 157.0 03:58:47 INFO - PROCESS | 21250 | 03:58:47 INFO - PROCESS | 21250 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 03:58:47 INFO - PROCESS | 21250 | Values: 68.0 66.0 67.0 67.0 69.0 67.0 66.0 66.0 67.0 66.0 03:58:47 INFO - PROCESS | 21250 | -------- Summary: end -------- 03:58:47 INFO - PROCESS | 21250 | 03:58:48 INFO - TEST-INFO | 21250: exit 0 03:58:48 INFO - TEST-OK | kraken | took 60778ms 03:58:48 INFO - SUITE-END | took 1174s 03:58:48 INFO - Completed test suite (00:19:34) 03:58:48 INFO - javascript benchmark 03:58:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.094399040264, 3353.698167164956, 3358.848851801668, 3378.560787097677, 3402.965970340297, 5593.664380137195, 5603.019471592475, 5603.467670571299, 5610.915836262459, 5612.859678508039, 5584.692841893694, 5633.661980281176, 5643.887122257553, 5646.915296270559, 5648.378678345379, 4966.652334336598, 5083.339165908436, 5166.276721259027, 5219.86950326243, 5243.606729495284, 5058.367704036996, 5087.211482220262, 5122.92315615266, 5123.129068058421, 5127.820526281581, 5127.820526281562, 5181.274621552986, 5197.882455272115, 5197.922031169535, 5238.292830467895, 5118.872028199306, 5118.897622047575, 5133.794648214104, 5138.100832354323, 5166.535011848933, 4973.701577905301, 4991.251312303184, 5005.424376196711, 5031.597472202215, 5062.063518249136, 5453.100238460649, 5509.47659972302, 5512.724363781795, 5519.475649813261, 5523.6685798852195, 5969.462748352669, 6011.368806275322, 6014.849628759316, 6017.789377371815, 6024.608400453956, 5968.731407086648, 6045.455908968214, 6055.271258845944, 6072.605280656743, 6074.696265186723, 5593.496585307301, 5646.604737668365, 5653.349864765563, 5656.8020119295625, 5656.830295091113, 5984.790532331434, 6127.486424087131, 6132.172156758869, 6143.201383820075, 6153.353897840662, 5888.411158884077, 5949.8215053548465, 5955.255593050869, 5963.522918166536, 5974.2233509643465, 5934.1692163097205, 5940.821775346746, 5945.672987985702, 5947.345791962881, 5952.0, 5800.8259752207505, 5906.734196961147, 5919.6152250103605, 5928.822135335947, 5929.584929055011, 5940.732667029994, 5942.70286485674, 5963.075723262901, 5969.910451343233, 5973.820785376359, 4557.088582283556, 4566.155261276608, 4568.109218702321, 4577.404937358122, 4596.17268891596, 4004.0790618157985, 4059.7970101494807, 4108.938365924513, 4119.938200926988, 4132.8140233689555, 5633.690147041952, 5657.066584013592, 5659.518940889988, 5662.5753068520025, 5699.031164702011, 5881.941180588139, 5926.199963005025, 5928.110783382441, 5932.881342373128, 5946.0, 5558.166275058693, 5641.153826925912, 5653.604247702704, 5718.599698021098, 5719.542436605062, 5146.819861304836, 5152.227165925066, 5165.044466773659, 5175.767090480937, 5196.818111366084, 6264.123022776815, 6264.498840092781, 6285.811425657238, 6296.527760417987, 6298.842528936813, 5904.114382842608, 5954.612950158225, 6001.159837622824, 6045.667488288186, 6059.0608455689435, 6225.782097626561, 6238.189035425366, 6258.843528911813, 6271.749130034747, 6294.968525157345, 5868.413158684098, 5868.735906884115, 5879.029960056543, 5879.94120058811, 5903.0, 5869.148973398748, 5980.730867111078, 5998.7300571473515, 6070.180525628984, 6078.6048906820915, 5803.912941305799, 5805.970970145122, 5839.708014599168, 5843.094320380348, 5849.473547380756, 5771.307443106854, 5837.182794408701, 5843.678597677169, 5844.0, 5848.298204215351, 5589.469000444951, 5769.826905192851, 5809.477147056785, 5843.503302219359, 5859.560532959959, 5896.439838215363, 5901.232839730979, 5904.3210030847, 5922.585419020627, 5923.733431995484, 5701.0, 5814.04068328721, 5824.708764561839, 5825.533957283492, 5846.152307915413], "value": 5530.710150871095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.2834055814137, 662.9966850165748, 666.0142988377202, 676.9153855768029, 678.5792808458756, 31319.21701957452, 31900.0, 39045.0, 39785.40321895174, 39803.0, 41170.7941460293, 41834.16331673365, 41891.790541047325, 41934.58065419352, 42151.57848421515, 7814.76555703327, 8614.784630384227, 8779.078196789342, 8795.0, 10219.591216351337, 10217.080462758351, 10342.276040677156, 10350.482475876213, 10350.844737328945, 10363.067323940844, 10353.896461035407, 10430.530626121843, 10430.739231519197, 10436.478176091203, 10456.634017809378, 10281.588736450532, 10283.971602839694, 10289.948550257239, 10311.63909263176, 10397.32417392867, 10238.129758970497, 10347.120494757879, 10373.11828494579, 10705.197110216764, 10722.892771072346, 42320.0, 42478.0, 42542.78728606368, 42665.786671066446, 43047.0, 3791.539588862053, 3860.4595356650093, 3904.921901561953, 3948.4866967294356, 3979.064919743887, 32701.0, 32908.6709132908, 32963.0, 33222.0, 33239.50140747891, 4336.804843782037, 4349.434573505456, 4368.279233926399, 4417.050334178167, 4468.218061839165, 322678.0, 324153.0, 324413.0, 324780.0, 325170.0, 59902.40097599055, 60521.39478605158, 60927.39072609217, 60984.0, 61123.0, 64091.67954160293, 69011.3098869015, 71302.0, 71314.0, 71372.28627713761, 18449.0, 18561.90719046396, 18587.81412185861, 18591.53521161982, 18591.81408185928, 13603.183808971493, 14349.713005740035, 14624.341904614104, 14818.259087045604, 14841.925790370979, 19991.900040499706, 19999.500012499513, 20007.699884501744, 20049.799502005084, 20125.899370503346, 7123.2520585338825, 7243.56732450662, 7297.3432391084, 7478.962605186939, 7581.962090189624, 1151.234429104636, 1159.287038471351, 1172.9560690985031, 1175.4122938530734, 1253.7555176740448, 33478.330433391195, 34112.82943585266, 34619.653803461646, 34750.0, 34829.825850870584, 1245.520474617279, 1254.9686257843628, 1314.7304802515653, 1370.7532644123953, 1400.2928521096985, 17905.7314140288, 17940.19269132892, 18163.81836181621, 18178.727319090223, 18234.270629174684, 482686.0, 486834.0, 486977.0, 489248.0, 492168.0, 61497.0, 62312.0, 62362.376376235654, 62364.688176558826, 62420.0, 1497.4534294982252, 1515.6968606278567, 1516.4464970285767, 1533.1337794146273, 1615.878809089323, 30650.846745766128, 31357.686423135478, 32385.190370240933, 32566.0, 33521.0, 49996.0, 50221.497785023144, 50295.0, 50582.24126638177, 50590.49409506005, 282176.0, 286433.0, 287197.0, 289311.0, 289327.0, 27152.185434436997, 30188.84905575458, 30568.541471878383, 31318.0, 31321.37357252888, 44791.776041119585, 45064.774676126406, 45364.773176135226, 46342.0, 47134.0, 37217.5458566739, 37232.81383593065, 38059.2388152241, 38286.42570361391, 38707.225855483295, 38412.61587384091, 38517.80741096276, 38534.6146538531, 38633.0, 41287.793561032006, 41466.37800432936, 42136.0, 42751.358729618456, 43055.569444305154, 43421.56578434175, 36176.63823361838, 36755.0, 37236.81381593075, 37670.62329376781, 37988.62011379851, 28098.71901280961, 28279.657501037655, 28626.713732862405, 28957.710422895503, 30607.387852243275], "value": 20755.267849992306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.89152711822044, 442.79631369569995, 446.3750748951468, 446.7766116941529, 454.8658145846975, 18744.2502299908, 18949.62100757986, 19377.806221937793, 20631.896840515816, 20680.0, 20048.29830955917, 20234.08946597403, 20550.588988220265, 20554.48613784656, 20587.588248235064, 5011.448740638536, 5278.868028299304, 5287.841364759063, 5288.0745869472885, 5290.2064690296575, 3993.5207775067033, 4407.625351845097, 4922.483139270379, 4998.3502144721315, 6593.044008618747, 6517.543771935966, 6543.640099794509, 6559.622479279357, 6560.803175904706, 6562.179727534059, 6109.908351374733, 6397.10440538325, 6414.775482858125, 6504.121943537632, 6507.739690412378, 5649.887002259973, 5758.79844205455, 5767.625104368202, 5780.479756821865, 5790.218320526717, 14041.859581404158, 14286.071405358618, 14424.134551926812, 14432.855671443256, 19102.71345929812, 2422.5222614205495, 2492.6385674077337, 2502.2993561802723, 2557.9104731334314, 2561.5389229938605, 10401.323913945645, 10588.100011499031, 10827.133829293638, 13885.583432497042, 14575.833933285312, 2054.4658388819016, 2060.701198326234, 2124.5432232070025, 2127.6808378805085, 2130.4141361125658, 62606.68696656533, 64559.67720161369, 65019.34980650227, 69798.95301570531, 73072.63463682648, 10989.835152472719, 11239.325640461599, 11295.209335346446, 11481.311121332747, 11584.131190160602, 15963.680726385408, 16082.43711470093, 16107.516774496784, 16128.919355403383, 16141.67716645684, 8874.979377371556, 8992.460452372748, 9007.684731034382, 9031.683891063782, 9073.95463022694, 8912.55437228136, 8965.417247878868, 8980.236679882153, 9188.310876684276, 9225.769355766026, 4606.608438282784, 4829.227323628203, 5003.924941125886, 5008.098542262428, 5216.087184742655, 2070.3788863340937, 2075.2010475966863, 2109.862858914166, 2118.2691971269887, 2161.9891900540397, 990.3117333453181, 996.272720913737, 1039.0804138337626, 1097.2154909239932, 1162.604714397109, 11989.22070065443, 18984.240630374905, 19035.238590456225, 19178.520536986685, 19603.411897643095, 518.2795913679988, 520.8671788693858, 526.1134987545921, 526.468267050282, 530.7266757619828, 6099.329073801879, 6890.138732658418, 6895.103636527319, 6930.965345173343, 6966.3730264276455, 521066.0, 547208.0, 563095.0, 573515.0, 584883.0, 93523.53238233765, 95416.0, 96270.51864740772, 98194.50902745583, 99718.5014074925, 509.9031184075014, 535.2773755430138, 537.7123239067158, 557.4926816596958, 560.28563581434, 11498.310101393943, 11619.302841829518, 11643.88356116428, 11700.824487632523, 11886.881131188924, 35978.64021359753, 36558.63441365552, 37365.0, 37924.62075379211, 38389.99999999888, 55272.72363638317, 55776.72111639416, 55822.0, 56118.43881561132, 56383.43616563782, 9301.069893010645, 9343.112404321579, 9498.335116541775, 9511.557869123846, 9538.14156725898, 13252.20486770797, 14222.573322799919, 14296.428142874169, 14480.710385792014, 14493.492727754478, 12271.877281227431, 12322.507099715911, 12325.50697972071, 12363.505459781509, 12613.243205407705, 12240.69398265015, 12313.458943475292, 12386.504539818307, 12404.379781011094, 12442.937785311378, 12331.630051098482, 12496.687582810502, 12573.874261257637, 12757.362131893182, 12762.29807360604, 9219.262459003397, 9408.858867116862, 9414.905850941403, 9453.385529940531, 9473.100055494717, 9512.95243523778, 11255.7748845021, 11879.109066820196, 11917.22538035025, 12270.509179632714], "value": 8891.483841881198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.2824595333398, 1558.0, 1562.9062256264624, 1773.6807374672553, 1928.5949950510392, 7066.929330706691, 7920.485168464046, 8060.193980601937, 8065.395095367841, 8069.273765361117, 7736.574488403136, 7884.96057519713, 7889.566073865935, 7905.604719764017, 7906.762797116081, 2418.504206637644, 2424.200013995386, 2441.084593277521, 2444.095684596693, 2448.8897999590063, 2327.8836058197107, 2382.2376839411395, 2383.630537266718, 2390.6414037894283, 2401.1955994741784, 2437.792787613055, 2451.1175976648483, 2456.9262922112275, 2490.140901389027, 2493.9376515587073, 2408.0969636386353, 2445.7065152181676, 2458.409981604411, 2465.0139944022444, 2465.765752253542, 2337.953240935172, 2400.2079313826393, 2407.6749638798715, 2407.879606019692, 2410.5660981023407, 7012.123484564429, 7737.535747855147, 8103.2707056364625, 8154.633041513146, 8163.918360816375, 5149.356330458692, 5240.056789777838, 5280.788768449257, 5290.55030322423, 5293.497117773805, 3477.4609935460044, 3485.825708714554, 3544.3088597723454, 3597.406427939387, 3599.982000090009, 1118.6420345489446, 1179.351356753782, 1185.7213554814698, 1200.5413422691472, 1213.2599114540124, 11058.612948546843, 11368.60209892658, 11402.71493212668, 11441.141914356373, 11464.770704585862, 4657.371254880615, 4683.461401938753, 4739.739314337676, 4753.382060332204, 4758.857234282977, 9866.358686685342, 9889.75275618101, 9903.158231550398, 9904.653337133166, 9917.553710083064, 5343.893122137535, 5349.331333583302, 5349.625526213205, 5355.812546560852, 5355.839324820184, 4827.61379089672, 4877.829275975395, 4881.633877459134, 4890.804367825247, 4899.706017638953, 3743.5320584926885, 3799.0312470320446, 3827.483289755903, 3857.556381016163, 3862.4592557042038, 1150.9482073306722, 1156.8380426740264, 1165.120334147713, 1177.6584790410684, 1180.5867946218755, 923.5890028937193, 1026.707388394304, 1039.6309310194922, 1040.422565476168, 1040.6929955663097, 5603.187537806995, 5717.142428635655, 5736.282964629421, 5809.0124678804705, 5827.562932779973, 1033.751899544104, 1034.5809946971488, 1039.2205845615788, 1044.8223801953534, 1061.098066643347, 3411.1642647551507, 3921.039345360348, 4024.9798751006642, 4058.6955978301744, 4079.714419990572, 9475.052494750607, 10204.132648724793, 10355.223358248162, 10360.585576576852, 10392.116670083127, 10209.183265338903, 10225.539850706737, 10232.232582556338, 10253.128484078938, 10266.435346056038, 7620.657070431844, 7693.038370203724, 7770.728024519115, 7792.649330780128, 7802.843943121105, 5463.808766693147, 5469.644473109394, 5504.724763761876, 5573.164025396223, 5691.971540142273, 8883.37816352849, 8941.776455588662, 8942.776430589287, 8964.32767542424, 9012.0, 8774.254188394058, 8948.910510894808, 8951.597178126869, 9116.726498205064, 9120.0, 7393.186749457663, 7425.554466732014, 7467.253274672489, 7475.36459400957, 7510.586917719578, 7853.410994175574, 7900.960495197487, 7903.960480197792, 7910.169432209535, 7911.564863932539, 6956.234814170336, 7048.365647091787, 7120.252373500915, 7360.705571777069, 7464.813379665552, 7106.857862842611, 7151.106111736033, 7235.131784185932, 7260.96369518149, 7270.0, 6724.058631791651, 6832.453403727789, 6840.076589660531, 6860.382565569123, 6873.48448866347, 5177.611679124006, 5184.818531351385, 5209.426963033988, 5228.7647055883335, 5241.213817927189, 4267.80794864238, 4973.204287314013, 5087.414947280962, 5167.58659307247, 5213.296205012275], "value": 4527.394952218341, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.11647938393696, 360.64476490656705, 361.2413930745435, 376.5124164207353, 377.68085967357575, 6122.9387706122925, 6272.4041216084515, 6286.057091436282, 6288.434040936315, 6361.363863613637, 5941.197938278331, 6019.668918209497, 6207.348228436017, 6214.440700336969, 6243.937560624404, 4795.0889331027165, 4831.6859404138795, 4831.7584120794, 4833.589144922686, 4846.68496547725, 4790.329353890458, 4837.32277481153, 4855.878603034935, 4856.5629093381585, 4862.6109911207195, 4558.0, 4679.251319788835, 4685.5548722871445, 4805.20714082176, 4809.855704328858, 4776.785044672998, 4777.498362671921, 4783.784729687138, 4786.928196077061, 4791.736454495001, 4232.365145228209, 4236.0, 4238.321868501056, 4241.936370954438, 4244.363345498169, 6021.427964343424, 6024.638521688669, 6031.306399764039, 6034.456898879078, 6038.456538911519, 5564.137558678412, 5572.275604171432, 5579.748911298961, 5580.162975553659, 5581.5813813963705, 6423.261324947644, 6557.967210163919, 6563.278039415661, 6565.507586930951, 6570.342965703391, 4662.976685116587, 4692.718436893797, 4696.506866779007, 4700.365450664151, 4701.694389864648, 6736.427403670694, 6799.456043516507, 6823.55646882951, 6834.316568343126, 6838.829029274259, 4789.425268967746, 4821.2045012572535, 4821.276808478756, 4824.421069471616, 4825.252085926687, 4870.975645121752, 4871.853844384604, 4875.926861097087, 4881.658283920163, 4882.145624515695, 5196.558292545101, 5372.7582258797665, 5431.131019036935, 5543.307086614173, 5554.1946417769195, 6556.246031706415, 6573.276939536647, 6573.506986975996, 6581.868362632817, 6592.868142637216, 1568.3021055630363, 1616.2161351744394, 1631.7797097391938, 1640.6882692288666, 1641.4172968596215, 1089.8583184186004, 1110.5280255891375, 1111.216592302425, 1115.3865374044244, 1125.5047778977223, 6351.491880649537, 6357.396047375492, 6357.936420635734, 6361.713722882481, 6366.618002919747, 6704.296048914891, 6704.363085506869, 6708.698108585126, 6718.428933540704, 6723.294054124344, 6339.0, 6343.746250150035, 6345.079963405373, 6350.7777227796805, 6351.904721429182, 3587.9641203588153, 3609.7112231021456, 3615.0420138663276, 3626.5648122225502, 3628.38317486028, 6857.588544687334, 7051.964740176369, 7184.209736928934, 7192.640367981685, 7206.711731530785, 6926.341997510229, 6936.132983377078, 6940.479464040217, 6940.930590694129, 6951.339622735832, 7128.572285662877, 7145.249748776408, 7161.319674630901, 7178.712851485987, 7179.138503379523, 6825.965870170618, 6841.281665425257, 6861.4853885957755, 6884.862302754017, 6910.101686780687, 6462.289148193601, 6674.499412544175, 6724.899126513008, 6730.293319201413, 6734.057231987427, 7048.506604537633, 7072.504924655431, 7138.785836424916, 7156.928430715626, 7157.57054576727, 4647.628189744744, 4681.461631912373, 4695.694779839299, 4696.647751418589, 4699.976500117477, 6541.34586541342, 6797.72809087631, 6804.863902722017, 6808.285130061272, 6818.795436136924, 6401.231852177769, 6493.8701225976165, 6495.1556297681, 6603.636799976048, 6643.269240383651, 6517.967410162919, 6579.243387010555, 6589.110470086669, 6598.406143447113, 6604.108445359815, 6487.578307410004, 6492.48060155177, 6497.740090396331, 6502.0246962955935, 6503.089567460654, 6547.1161393213215, 6590.439812615981, 6608.471322294301, 6648.83377915556, 6658.400743932875, 6458.225012998282, 6495.512836537373, 6496.7726129585235, 6497.805065848032, 6509.576877502947], "value": 4995.84608166249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.5697131120917, 839.7774589733725, 884.6019291318906, 891.7369376034071, 917.4128557723054, 15741.921290393546, 15891.761623575627, 15952.601184970381, 17031.318747250094, 17483.475495735118, 15997.920010399961, 16121.355145794154, 16130.83869161311, 16213.594660133502, 16214.0, 760.3536993555489, 906.9093090690944, 913.8720579118929, 926.8146370725848, 927.638221093774, 924.685606893656, 925.6436272035281, 927.6057675487891, 929.6746138851382, 929.8000929800091, 783.5024759277871, 962.3600305796637, 962.7256231973889, 962.8363178259677, 968.3366893677818, 787.7282337593521, 949.1742184299669, 956.7751578379075, 958.750724811547, 958.9232861371108, 697.4873468001015, 701.8175274428635, 705.3334598804132, 706.9505134640577, 712.6721708014268, 15340.079595224322, 15355.232238388036, 15386.615334616612, 15432.151231682254, 15459.613509662237, 13888.930555347159, 14218.0, 14422.206778627276, 14432.494862679756, 14480.710385792225, 12466.937665311707, 12580.622581322576, 12601.810972835416, 12650.240985540897, 12728.363581820871, 4034.9193016139807, 4138.503379594438, 4139.544650088488, 4161.854335098287, 4177.143685544456, 54473.1829022565, 55519.16721249185, 55707.0, 55900.44099559034, 62150.378496215366, 11676.241044332091, 11815.232009919328, 11974.22167559106, 12073.818892716616, 12204.0, 20887.164513419597, 20923.163073477193, 20955.790442095687, 20973.47566310824, 20994.160233590486, 9000.729978100668, 9049.276057915351, 9088.04575519574, 9145.314101442418, 9148.176664100263, 5067.923981140286, 5125.666831656005, 5163.277141200235, 5201.843944681666, 5234.18870075139, 3484.26830365621, 3486.389881770731, 3533.5406397168204, 3545.2023294758474, 3546.255286389887, 620.8385819686914, 684.4045680258207, 714.8705046027368, 724.9746258880914, 731.7146312937958, 706.1561434086218, 785.9724909628136, 800.6757263308369, 819.6393586821779, 842.8819965204754, 9828.655997040069, 9838.950805245928, 9949.353292035994, 9980.650677226262, 10193.745156371002, 708.6563016936782, 832.9541875196801, 838.6729175621513, 840.3193413335218, 856.9228769410782, 4572.81708731647, 4589.35748995141, 4701.48283688794, 4715.528447155257, 4757.333973243749, 61714.0, 62278.37721622817, 62506.37493625005, 62606.37393626096, 62698.37301626925, 58958.70520647455, 59942.40057599456, 60776.0, 60792.0, 60934.0, 52630.21054684183, 53325.73337133367, 53446.732766336696, 54118.18822717662, 54187.0, 8996.190342869173, 8998.910010899806, 9074.909250907407, 9140.6800761973, 9317.11487408695, 38507.42238866475, 39498.40752388659, 39853.601463986146, 40012.1997560053, 40270.39594406028, 46160.0, 46277.537224627325, 51515.0, 51750.223746643074, 52240.73879630578, 11922.403879806148, 11960.0, 12015.459304331502, 12129.9083082523, 12338.0, 12768.936155319536, 12922.0, 13620.386205108629, 14284.57146285613, 14552.41790328375, 13434.395452204479, 13442.663933401744, 13802.792958105838, 13894.166350019032, 14464.20446875432, 13538.187708737507, 13634.454621815017, 13819.378127984466, 13828.239446830119, 14004.929975350058, 12969.286689232184, 13060.80408793888, 13258.071934964846, 13375.130616509896, 13931.373088211258, 11137.665870023913, 11439.828402573801, 11533.480993355151, 11541.596044138414, 11721.12091593151, 11181.608643697431, 11259.79290395889, 11602.18784685064, 11632.88367116318, 11671.941640291745], "value": 7309.410606585795, "unit": "score"}], "name": "dromaeo_css", "value": 7433.794481910556, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 110.0, 111.0, 112.0, 105.0, 110.0, 110.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 131.0, 154.0, 184.0, 128.0, 157.0, 153.0, 127.0, 183.0, 126.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 181.0, 76.0, 76.0, 74.0, 77.0, 172.0, 76.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 149.0, 92.0, 94.0, 93.0, 155.0, 93.0, 92.0, 154.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 147.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 55.0, 54.0, 53.0, 69.0, 51.0, 52.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 65.0, 58.0, 58.0, 59.0, 57.0, 57.0, 62.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 76.0, 81.0, 73.0, 73.0, 73.0, 74.0, 73.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 114.0, 116.0, 109.0, 115.0, 120.0, 112.0, 129.0, 126.0], "value": 117.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 157.0, 159.0, 158.0, 159.0, 158.0, 166.0, 164.0, 157.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 69.0, 67.0, 66.0, 66.0, 67.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1515.7, "alertThreshold": 2.0}]} 03:58:48 INFO - Return code: 0 03:58:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:58:48 ERROR - # TBPL SUCCESS # 03:58:48 INFO - Running post-action listener: _resource_record_post_action 03:58:48 INFO - Running post-run listener: _resource_record_post_run 03:58:49 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 461942784; Read time: 0; Write time: 1504736 03:58:49 INFO - install - Wall time: 15s; CPU: 20.0%; Read bytes: 0; Write bytes: 243425280; Read time: 0; Write time: 1249200 03:58:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 218517504; Read time: 0; Write time: 255536 03:58:49 INFO - Running post-run listener: _upload_blobber_files 03:58:49 INFO - Blob upload gear active. 03:58:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:58:49 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 03:58:49 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'] 03:58:49 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 03:58:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:58:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:58:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:50 INFO - (blobuploader) - INFO - Done attempting. 03:58:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:58:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:58:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:51 INFO - (blobuploader) - INFO - Done attempting. 03:58:51 INFO - (blobuploader) - INFO - Iteration through files over. 03:58:51 INFO - Return code: 0 03:58:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:58:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:58:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d481f2d8e7ea13097370f5fd06507c4338d31f882b8ae30e13a7a36f236186e21b4be645f0fc085a7e7c5fdd5c06a839d31defe7741ba25b9c65c672fee21a61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a1201710e0a67757382d70fd6f16643fd62f8c1f897102e6977ab8689a104f865c8f458f9ced1e446218136dc1677f5d14e896534e9f26e131feec01cccd716e"} 03:58:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:58:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:58:51 INFO - Contents: 03:58:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d481f2d8e7ea13097370f5fd06507c4338d31f882b8ae30e13a7a36f236186e21b4be645f0fc085a7e7c5fdd5c06a839d31defe7741ba25b9c65c672fee21a61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a1201710e0a67757382d70fd6f16643fd62f8c1f897102e6977ab8689a104f865c8f458f9ced1e446218136dc1677f5d14e896534e9f26e131feec01cccd716e"} 03:58:51 INFO - Running post-run listener: copy_logs_to_upload_dir 03:58:51 INFO - Copying logs to upload dir... 03:58:51 INFO - mkdir: /builds/slave/test/build/upload/logs 03:58:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.211066 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-21 03:58:51.459580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 03:58:51.463015) ========= 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=df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d481f2d8e7ea13097370f5fd06507c4338d31f882b8ae30e13a7a36f236186e21b4be645f0fc085a7e7c5fdd5c06a839d31defe7741ba25b9c65c672fee21a61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a1201710e0a67757382d70fd6f16643fd62f8c1f897102e6977ab8689a104f865c8f458f9ced1e446218136dc1677f5d14e896534e9f26e131feec01cccd716e"} build_url:https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/RL2Zuw8NQo6dg75yp2sgSA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d481f2d8e7ea13097370f5fd06507c4338d31f882b8ae30e13a7a36f236186e21b4be645f0fc085a7e7c5fdd5c06a839d31defe7741ba25b9c65c672fee21a61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a1201710e0a67757382d70fd6f16643fd62f8c1f897102e6977ab8689a104f865c8f458f9ced1e446218136dc1677f5d14e896534e9f26e131feec01cccd716e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 03:58:51.492776) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:58:51.493107) ========= 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=df17445c3590ff7897617a0e00000225-1466505433.681181-1368117981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:58:51.576226) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 03:58:51.576962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 03:58:51.577609) ========= ========= Total master_lag: 0.27 =========