builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1468501899.57 results: success (0) buildid: 20160714032944 builduid: 812c73301a974d79948548f295568140 revision: 6c4ced3ac243a3e36549904fbe5f889a7a7deaab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:39.572859) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:39.574978) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:39.575429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:39.591572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:39.591868) ========= 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=7de08804244eb36560b44971000001c3-1468501898.377813-1277435935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 06:11:39-- 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% 217M=0s 2016-07-14 06:11:39 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126992 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:39.733202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:39.733535) ========= 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=7de08804244eb36560b44971000001c3-1468501898.377813-1277435935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015536 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:39.783536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:39.783904) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6c4ced3ac243a3e36549904fbe5f889a7a7deaab --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-aurora --rev 6c4ced3ac243a3e36549904fbe5f889a7a7deaab --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=7de08804244eb36560b44971000001c3-1468501898.377813-1277435935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 06:11:40,091 truncating revision to first 12 chars 2016-07-14 06:11:40,091 Setting DEBUG logging. 2016-07-14 06:11:40,091 attempt 1/10 2016-07-14 06:11:40,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6c4ced3ac243?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 06:11:40,416 unpacking tar archive at: mozilla-aurora-6c4ced3ac243/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658971 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:40.456734) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:40.457073) ========= script_repo_revision: 6c4ced3ac243a3e36549904fbe5f889a7a7deaab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:40.457473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:40.457758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:11:40.466904) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-14 06:11:40.467292) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=7de08804244eb36560b44971000001c3-1468501898.377813-1277435935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:11:40 INFO - MultiFileLogger online at 20160714 06:11:40 in /builds/slave/test 06:11:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:11:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:11:40 INFO - {'append_to_log': False, 06:11:40 INFO - 'base_work_dir': '/builds/slave/test', 06:11:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:11:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:11:40 INFO - 'branch': 'Mozilla-Aurora', 06:11:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:11:40 INFO - 'config_files': ('talos/linux_config.py',), 06:11:40 INFO - 'default_actions': ('clobber', 06:11:40 INFO - 'read-buildbot-config', 06:11:40 INFO - 'download-and-extract', 06:11:40 INFO - 'populate-webroot', 06:11:40 INFO - 'create-virtualenv', 06:11:40 INFO - 'install', 06:11:40 INFO - 'run-tests'), 06:11:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:11:40 INFO - 'download_minidump_stackwalk': True, 06:11:40 INFO - 'download_symbols': 'ondemand', 06:11:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:11:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:11:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:11:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:11:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:11:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:11:40 INFO - 'installer_path': 'installer.exe', 06:11:40 INFO - 'log_level': 'info', 06:11:40 INFO - 'log_name': 'talos', 06:11:40 INFO - 'log_to_console': True, 06:11:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:11:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:11:40 INFO - 'opt_config_files': (), 06:11:40 INFO - 'pip_index': False, 06:11:40 INFO - 'sps_profile': False, 06:11:40 INFO - 'sps_profile_interval': 0, 06:11:40 INFO - 'suite': 'dromaeojs', 06:11:40 INFO - 'system_bits': '32', 06:11:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:11:40 INFO - 'title': 'talos-linux64-ix-003', 06:11:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:11:40 INFO - 'use_talos_json': True, 06:11:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:11:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:11:40 INFO - 'work_dir': 'build'} 06:11:40 INFO - ##### 06:11:40 INFO - ##### Running clobber step. 06:11:40 INFO - ##### 06:11:40 INFO - Running pre-action listener: _resource_record_pre_action 06:11:40 INFO - Running main action method: clobber 06:11:40 INFO - rmtree: /builds/slave/test/build 06:11:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:11:41 INFO - Running post-action listener: _resource_record_post_action 06:11:41 INFO - ##### 06:11:41 INFO - ##### Finished clobber step (success) 06:11:41 INFO - ##### 06:11:41 INFO - ##### 06:11:41 INFO - ##### Running read-buildbot-config step. 06:11:41 INFO - ##### 06:11:41 INFO - Running pre-action listener: _resource_record_pre_action 06:11:41 INFO - Running main action method: read_buildbot_config 06:11:41 INFO - Using buildbot properties: 06:11:41 INFO - { 06:11:41 INFO - "project": "", 06:11:41 INFO - "product": "firefox", 06:11:41 INFO - "script_repo_revision": "production", 06:11:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:11:41 INFO - "repository": "", 06:11:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:11:41 INFO - "buildid": "20160714032944", 06:11:41 INFO - "pgo_build": "True", 06:11:41 INFO - "basedir": "/builds/slave/test", 06:11:41 INFO - "buildnumber": 607, 06:11:41 INFO - "slavename": "talos-linux64-ix-003", 06:11:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:11:41 INFO - "platform": "ubuntu64_hw", 06:11:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:11:41 INFO - "branch": "mozilla-aurora", 06:11:41 INFO - "repo_path": "releases/mozilla-aurora", 06:11:41 INFO - "revision": "6c4ced3ac243a3e36549904fbe5f889a7a7deaab", 06:11:41 INFO - "stage_platform": "linux64-pgo", 06:11:41 INFO - "builduid": "812c73301a974d79948548f295568140", 06:11:41 INFO - "slavebuilddir": "test" 06:11:41 INFO - } 06:11:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 06:11:41 INFO - Running post-action listener: _resource_record_post_action 06:11:41 INFO - ##### 06:11:41 INFO - ##### Finished read-buildbot-config step (success) 06:11:41 INFO - ##### 06:11:41 INFO - ##### 06:11:41 INFO - ##### Running download-and-extract step. 06:11:41 INFO - ##### 06:11:41 INFO - Running pre-action listener: _resource_record_pre_action 06:11:41 INFO - Running main action method: download_and_extract 06:11:41 INFO - mkdir: /builds/slave/test/build/tests 06:11: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')]} 06:11:41 INFO - https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:11:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:11:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:11:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:11:42 INFO - Downloaded 1361 bytes. 06:11:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:11:42 INFO - Using the following test package requirements: 06:11:42 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:11:42 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:11:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:11:42 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:11:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:11:42 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:11:42 INFO - u'jsshell-linux-x86_64.zip'], 06:11:42 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:11:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:11:42 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:11:42 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:11:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:11:42 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:11:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:11:42 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:11:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:11:42 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:11:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:11:42 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:42 INFO - https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:11:43 INFO - Downloaded 24491019 bytes. 06:11:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:11:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:11:44 INFO - Return code: 0 06:11:44 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:11: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')]} 06:11:44 INFO - https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:11:46 INFO - Downloaded 24491019 bytes. 06:11:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:11:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:11:47 INFO - Return code: 0 06:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:47 INFO - https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:11:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:11:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:11:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:11:48 INFO - Downloaded 10833369 bytes. 06:11:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:11:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:11:48 INFO - Return code: 0 06:11: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')]} 06:11:48 INFO - https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:11:50 INFO - Downloaded 63629477 bytes. 06:11:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:11:50 INFO - mkdir: /builds/slave/test/properties 06:11:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:11:50 INFO - Writing to file /builds/slave/test/properties/build_url 06:11:50 INFO - Contents: 06:11:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:11:51 INFO - Running post-action listener: _resource_record_post_action 06:11:51 INFO - Running post-action listener: set_extra_try_arguments 06:11:51 INFO - ##### 06:11:51 INFO - ##### Finished download-and-extract step (success) 06:11:51 INFO - ##### 06:11:51 INFO - ##### 06:11:51 INFO - ##### Running populate-webroot step. 06:11:51 INFO - ##### 06:11:51 INFO - Running pre-action listener: _resource_record_pre_action 06:11:51 INFO - Running main action method: populate_webroot 06:11:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:11:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:11:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:11:51 INFO - '--tppagecycles', 06:11:51 INFO - '7'], 06:11:51 INFO - 'tests': ['tsvgm']}}, 06:11:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:11:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:11:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:11:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:11:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:11:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:11:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:51 INFO - 'talos_options': ['--disable-e10s'], 06:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:51 INFO - 'talos_options': ['--disable-e10s'], 06:11:51 INFO - 'tests': ['damp', 'tps']}, 06:11:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:51 INFO - 'tests': ['damp', 'tps']}, 06:11:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:11:51 INFO - 'tests': ['dromaeo_dom']}, 06:11:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:11:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:11:51 INFO - 'tests': ['a11yr', 06:11:51 INFO - 'ts_paint', 06:11:51 INFO - 'tpaint', 06:11:51 INFO - 'sessionrestore', 06:11:51 INFO - 'sessionrestore_no_auto_restore', 06:11:51 INFO - 'tabpaint']}, 06:11:51 INFO - 'other-e10s': {'tests': ['a11yr', 06:11:51 INFO - 'ts_paint', 06:11:51 INFO - 'tpaint', 06:11:51 INFO - 'sessionrestore', 06:11:51 INFO - 'sessionrestore_no_auto_restore', 06:11:51 INFO - 'tabpaint']}, 06:11:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:11:51 INFO - 'ts_paint', 06:11:51 INFO - 'tpaint', 06:11:51 INFO - 'sessionrestore', 06:11:51 INFO - 'sessionrestore_no_auto_restore', 06:11:51 INFO - 'tabpaint']}, 06:11:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:11:51 INFO - 'ts_paint', 06:11:51 INFO - 'tpaint', 06:11:51 INFO - 'sessionrestore', 06:11:51 INFO - 'sessionrestore_no_auto_restore', 06:11:51 INFO - 'tabpaint']}, 06:11:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:11:51 INFO - 'tests': ['a11yr', 06:11:51 INFO - 'ts_paint', 06:11:51 INFO - 'tpaint', 06:11:51 INFO - 'sessionrestore', 06:11:51 INFO - 'sessionrestore_no_auto_restore', 06:11:51 INFO - 'tabpaint']}, 06:11:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:11:51 INFO - 'tests': ['a11yr', 06:11:51 INFO - 'ts_paint', 06:11:51 INFO - 'tpaint', 06:11:51 INFO - 'sessionrestore', 06:11:51 INFO - 'sessionrestore_no_auto_restore', 06:11:51 INFO - 'tabpaint']}, 06:11:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:11:51 INFO - 'tests': ['tsvgx', 06:11:51 INFO - 'tsvgr_opacity', 06:11:51 INFO - 'tart', 06:11:51 INFO - 'tscrollx', 06:11:51 INFO - 'cart']}, 06:11:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:11:51 INFO - 'tsvgr_opacity', 06:11:51 INFO - 'tart', 06:11:51 INFO - 'tscrollx', 06:11:51 INFO - 'cart']}, 06:11:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:51 INFO - 'talos_options': ['--disable-e10s'], 06:11:51 INFO - 'tests': ['tp5o']}, 06:11:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:51 INFO - 'tests': ['tp5o']}, 06:11:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:51 INFO - 'talos_options': ['--disable-e10s', 06:11:51 INFO - '--xperf_path', 06:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:51 INFO - 'tests': ['tp5n']}, 06:11:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:51 INFO - 'talos_options': ['--xperf_path', 06:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:51 INFO - 'tests': ['tp5n']}}, 06:11:51 INFO - 'talos.zip': {'path': '', 06:11:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:11:51 INFO - Running post-action listener: _resource_record_post_action 06:11:51 INFO - ##### 06:11:51 INFO - ##### Finished populate-webroot step (success) 06:11:51 INFO - ##### 06:11:51 INFO - ##### 06:11:51 INFO - ##### Running create-virtualenv step. 06:11:51 INFO - ##### 06:11:51 INFO - Running pre-action listener: _resource_record_pre_action 06:11:51 INFO - Running main action method: create_virtualenv 06:11:51 INFO - Creating virtualenv /builds/slave/test/build/venv 06:11:51 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 06:11:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:11:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:11:51 INFO - Using real prefix '/usr' 06:11:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:11:51 INFO - Installing distribute.............................................................................................................................................................................................done. 06:11:53 INFO - Installing pip.................done. 06:11:53 INFO - Return code: 0 06:11:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:53 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 0x7fe4f6996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, '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': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', '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 06:11:53 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 06:11:53 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 06:11:53 INFO - Using env: {'DISPLAY': ':0', 06:11:53 INFO - 'HOME': '/home/cltbld', 06:11:53 INFO - 'LANG': 'en_US.UTF-8', 06:11:53 INFO - 'LANGUAGE': 'en_US:en', 06:11:53 INFO - 'LOGNAME': 'cltbld', 06:11:53 INFO - 'MAIL': '/var/mail/cltbld', 06:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:53 INFO - 'MOZ_NO_REMOTE': '1', 06:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:53 INFO - 'NO_EM_RESTART': '1', 06:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:53 INFO - 'PWD': '/builds/slave/test', 06:11:53 INFO - 'SHELL': '/bin/bash', 06:11:53 INFO - 'SHLVL': '1', 06:11:53 INFO - 'TERM': 'linux', 06:11:53 INFO - 'TMOUT': '86400', 06:11:53 INFO - 'USER': 'cltbld', 06:11:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:53 INFO - '_': '/tools/buildbot/bin/python'} 06:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:53 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 06:11:53 INFO - Cleaning up... 06:11:53 INFO - Return code: 0 06:11:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:53 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4f6996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, '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': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', '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 06:11:53 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>=3.1.1'] in /builds/slave/test/build 06:11:53 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>=3.1.1 06:11:53 INFO - Using env: {'DISPLAY': ':0', 06:11:53 INFO - 'HOME': '/home/cltbld', 06:11:53 INFO - 'LANG': 'en_US.UTF-8', 06:11:53 INFO - 'LANGUAGE': 'en_US:en', 06:11:53 INFO - 'LOGNAME': 'cltbld', 06:11:53 INFO - 'MAIL': '/var/mail/cltbld', 06:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:53 INFO - 'MOZ_NO_REMOTE': '1', 06:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:53 INFO - 'NO_EM_RESTART': '1', 06:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:53 INFO - 'PWD': '/builds/slave/test', 06:11:53 INFO - 'SHELL': '/bin/bash', 06:11:53 INFO - 'SHLVL': '1', 06:11:53 INFO - 'TERM': 'linux', 06:11:53 INFO - 'TMOUT': '86400', 06:11:53 INFO - 'USER': 'cltbld', 06:11:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:53 INFO - '_': '/tools/buildbot/bin/python'} 06:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:54 INFO - Downloading/unpacking psutil>=3.1.1 06:11: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 06:11: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 06:11: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 06:11: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 06:11: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 06:11: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 06:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:56 INFO - Installing collected packages: psutil 06:11:56 INFO - Running setup.py install for psutil 06:11:56 INFO - building 'psutil._psutil_linux' extension 06:11:56 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 06:11:56 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 06:11:56 INFO - building 'psutil._psutil_posix' extension 06:11:56 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 06:11:56 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 06:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:56 INFO - Successfully installed psutil 06:11:56 INFO - Cleaning up... 06:11:56 INFO - Return code: 0 06:11:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:11:56 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')]} 06:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:56 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')]} 06:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:56 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4f6996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, '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': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', '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 06:11:56 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.3'] in /builds/slave/test/build 06:11:56 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.3 06:11:56 INFO - Using env: {'DISPLAY': ':0', 06:11:56 INFO - 'HOME': '/home/cltbld', 06:11:56 INFO - 'LANG': 'en_US.UTF-8', 06:11:56 INFO - 'LANGUAGE': 'en_US:en', 06:11:56 INFO - 'LOGNAME': 'cltbld', 06:11:56 INFO - 'MAIL': '/var/mail/cltbld', 06:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:56 INFO - 'MOZ_NO_REMOTE': '1', 06:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:56 INFO - 'NO_EM_RESTART': '1', 06:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:56 INFO - 'PWD': '/builds/slave/test', 06:11:56 INFO - 'SHELL': '/bin/bash', 06:11:56 INFO - 'SHLVL': '1', 06:11:56 INFO - 'TERM': 'linux', 06:11:56 INFO - 'TMOUT': '86400', 06:11:56 INFO - 'USER': 'cltbld', 06:11:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:56 INFO - '_': '/tools/buildbot/bin/python'} 06:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:11: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 06:11: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 06:11: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 06:11: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 06:11: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 06:11: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 06:11:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:11:58 INFO - Installing collected packages: mozsystemmonitor 06:11:58 INFO - Running setup.py install for mozsystemmonitor 06:11:58 INFO - Successfully installed mozsystemmonitor 06:11:58 INFO - Cleaning up... 06:11:59 INFO - Return code: 0 06:11:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:59 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4f6996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, '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': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', '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 06:11:59 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==2.5.1'] in /builds/slave/test/build 06:11:59 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==2.5.1 06:11:59 INFO - Using env: {'DISPLAY': ':0', 06:11:59 INFO - 'HOME': '/home/cltbld', 06:11:59 INFO - 'LANG': 'en_US.UTF-8', 06:11:59 INFO - 'LANGUAGE': 'en_US:en', 06:11:59 INFO - 'LOGNAME': 'cltbld', 06:11:59 INFO - 'MAIL': '/var/mail/cltbld', 06:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:59 INFO - 'MOZ_NO_REMOTE': '1', 06:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:59 INFO - 'NO_EM_RESTART': '1', 06:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:59 INFO - 'PWD': '/builds/slave/test', 06:11:59 INFO - 'SHELL': '/bin/bash', 06:11:59 INFO - 'SHLVL': '1', 06:11:59 INFO - 'TERM': 'linux', 06:11:59 INFO - 'TMOUT': '86400', 06:11:59 INFO - 'USER': 'cltbld', 06:11:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:59 INFO - '_': '/tools/buildbot/bin/python'} 06:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:59 INFO - Downloading/unpacking jsonschema==2.5.1 06:11:59 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 06:11:59 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 06:11:59 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 06:11:59 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 06:11:59 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 06:11:59 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 06:12:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:12:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:12:01 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 06:12:01 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 06:12:01 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 06:12:01 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 06:12:01 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 06:12:01 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 06:12:01 INFO - Downloading functools32-3.2.3-2.tar.gz 06:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:12:01 INFO - warning: no files found matching '*.txt' 06:12:01 INFO - no previously-included directories found matching 'build' 06:12:01 INFO - no previously-included directories found matching 'dist' 06:12:01 INFO - no previously-included directories found matching '.git*' 06:12:01 INFO - Installing collected packages: jsonschema, functools32 06:12:01 INFO - Running setup.py install for functools32 06:12:01 INFO - warning: no files found matching '*.txt' 06:12:01 INFO - no previously-included directories found matching 'build' 06:12:01 INFO - no previously-included directories found matching 'dist' 06:12:01 INFO - no previously-included directories found matching '.git*' 06:12:01 INFO - Successfully installed jsonschema functools32 06:12:01 INFO - Cleaning up... 06:12:01 INFO - Return code: 0 06:12:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:01 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 0x7fe4f6996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, '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': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', '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 06:12:01 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 06:12:01 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 06:12:01 INFO - Using env: {'DISPLAY': ':0', 06:12:01 INFO - 'HOME': '/home/cltbld', 06:12:01 INFO - 'LANG': 'en_US.UTF-8', 06:12:01 INFO - 'LANGUAGE': 'en_US:en', 06:12:01 INFO - 'LOGNAME': 'cltbld', 06:12:01 INFO - 'MAIL': '/var/mail/cltbld', 06:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:01 INFO - 'MOZ_NO_REMOTE': '1', 06:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:01 INFO - 'NO_EM_RESTART': '1', 06:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:01 INFO - 'PWD': '/builds/slave/test', 06:12:01 INFO - 'SHELL': '/bin/bash', 06:12:01 INFO - 'SHLVL': '1', 06:12:01 INFO - 'TERM': 'linux', 06:12:01 INFO - 'TMOUT': '86400', 06:12:01 INFO - 'USER': 'cltbld', 06:12:01 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:01 INFO - '_': '/tools/buildbot/bin/python'} 06:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:01 INFO - Downloading/unpacking blobuploader==1.2.4 06:12:01 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 06:12:01 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 06:12:01 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 06:12:01 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 06:12:01 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 06:12:01 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 06:12:03 INFO - Downloading blobuploader-1.2.4.tar.gz 06:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:12:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:12:03 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 06:12:03 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 06:12:03 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 06:12:03 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 06:12:03 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 06:12:03 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 06:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:12:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:04 INFO - Downloading docopt-0.6.1.tar.gz 06:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:12:04 INFO - Installing collected packages: blobuploader, requests, docopt 06:12:04 INFO - Running setup.py install for blobuploader 06:12:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:12:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:12:04 INFO - Running setup.py install for requests 06:12:04 INFO - Running setup.py install for docopt 06:12:05 INFO - Successfully installed blobuploader requests docopt 06:12:05 INFO - Cleaning up... 06:12:05 INFO - Return code: 0 06:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:05 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')]} 06:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:05 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')]} 06:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:05 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 0x7fe4f6996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, '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': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', '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 06:12:05 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 06:12:05 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 06:12:05 INFO - Using env: {'DISPLAY': ':0', 06:12:05 INFO - 'HOME': '/home/cltbld', 06:12:05 INFO - 'LANG': 'en_US.UTF-8', 06:12:05 INFO - 'LANGUAGE': 'en_US:en', 06:12:05 INFO - 'LOGNAME': 'cltbld', 06:12:05 INFO - 'MAIL': '/var/mail/cltbld', 06:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:05 INFO - 'MOZ_NO_REMOTE': '1', 06:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:05 INFO - 'NO_EM_RESTART': '1', 06:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:05 INFO - 'PWD': '/builds/slave/test', 06:12:05 INFO - 'SHELL': '/bin/bash', 06:12:05 INFO - 'SHLVL': '1', 06:12:05 INFO - 'TERM': 'linux', 06:12:05 INFO - 'TMOUT': '86400', 06:12:05 INFO - 'USER': 'cltbld', 06:12:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:05 INFO - '_': '/tools/buildbot/bin/python'} 06:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:05 INFO - Running setup.py (path:/tmp/pip-39L7Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:05 INFO - Running setup.py (path:/tmp/pip-olW43w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:05 INFO - Running setup.py (path:/tmp/pip-WgVcWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:05 INFO - Running setup.py (path:/tmp/pip-qPmAnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:05 INFO - Running setup.py (path:/tmp/pip-N2cWAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:05 INFO - Running setup.py (path:/tmp/pip-KvfcG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:05 INFO - Running setup.py (path:/tmp/pip-RAcyXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:05 INFO - Running setup.py (path:/tmp/pip-NMC240-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:05 INFO - Running setup.py (path:/tmp/pip-XTVAME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:05 INFO - Running setup.py (path:/tmp/pip-sy4Ahn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:06 INFO - Running setup.py (path:/tmp/pip-B0e8yZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:06 INFO - Running setup.py (path:/tmp/pip-K3CbcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:06 INFO - Running setup.py (path:/tmp/pip-WcU0J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:06 INFO - Running setup.py (path:/tmp/pip-0fvMBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:06 INFO - Running setup.py (path:/tmp/pip-PKwLt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:06 INFO - Running setup.py (path:/tmp/pip-dlKNjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:06 INFO - Running setup.py (path:/tmp/pip-wOHmTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:12:06 INFO - Running setup.py install for manifestparser 06:12:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:12:06 INFO - Running setup.py install for mozcrash 06:12:06 INFO - Running setup.py install for mozdebug 06:12:06 INFO - Running setup.py install for mozdevice 06:12:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:12:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:12:06 INFO - Running setup.py install for mozfile 06:12:07 INFO - Running setup.py install for mozhttpd 06:12:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Running setup.py install for mozinfo 06:12:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Running setup.py install for mozInstall 06:12:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Running setup.py install for mozleak 06:12:07 INFO - Running setup.py install for mozlog 06:12:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Running setup.py install for moznetwork 06:12:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Running setup.py install for mozprocess 06:12:07 INFO - Running setup.py install for mozprofile 06:12:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Running setup.py install for mozrunner 06:12:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:12:07 INFO - Running setup.py install for mozscreenshot 06:12:08 INFO - Running setup.py install for moztest 06:12:08 INFO - Running setup.py install for mozversion 06:12:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:12:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:12:08 INFO - Cleaning up... 06:12:08 INFO - Return code: 0 06:12:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:08 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 0x7fe4f6996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, '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': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', '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 06:12:08 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 06:12:08 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 06:12:08 INFO - Using env: {'DISPLAY': ':0', 06:12:08 INFO - 'HOME': '/home/cltbld', 06:12:08 INFO - 'LANG': 'en_US.UTF-8', 06:12:08 INFO - 'LANGUAGE': 'en_US:en', 06:12:08 INFO - 'LOGNAME': 'cltbld', 06:12:08 INFO - 'MAIL': '/var/mail/cltbld', 06:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:08 INFO - 'MOZ_NO_REMOTE': '1', 06:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:08 INFO - 'NO_EM_RESTART': '1', 06:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:08 INFO - 'PWD': '/builds/slave/test', 06:12:08 INFO - 'SHELL': '/bin/bash', 06:12:08 INFO - 'SHLVL': '1', 06:12:08 INFO - 'TERM': 'linux', 06:12:08 INFO - 'TMOUT': '86400', 06:12:08 INFO - 'USER': 'cltbld', 06:12:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:08 INFO - '_': '/tools/buildbot/bin/python'} 06:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:08 INFO - Running setup.py (path:/tmp/pip-tuCCWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:08 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)) 06:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:08 INFO - Running setup.py (path:/tmp/pip-IAw4iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:08 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)) 06:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:08 INFO - Running setup.py (path:/tmp/pip-gyEfIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:08 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)) 06:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:08 INFO - Running setup.py (path:/tmp/pip-cFrcR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:08 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)) 06:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:08 INFO - Running setup.py (path:/tmp/pip-efWgj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:08 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)) 06:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:08 INFO - Running setup.py (path:/tmp/pip-fXcVKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:08 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)) 06:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:08 INFO - Running setup.py (path:/tmp/pip-lVuDxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:08 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)) 06:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:09 INFO - Running setup.py (path:/tmp/pip-zM635c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:09 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)) 06:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:09 INFO - Running setup.py (path:/tmp/pip-ldl4p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:09 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)) 06:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:09 INFO - Running setup.py (path:/tmp/pip-AOfo62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 06:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:09 INFO - Running setup.py (path:/tmp/pip-XGhXJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:09 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)) 06:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:09 INFO - Running setup.py (path:/tmp/pip-7SXJba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:09 INFO - Running setup.py (path:/tmp/pip-6pZ2vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:09 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)) 06:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:09 INFO - Running setup.py (path:/tmp/pip-3_uChB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:09 INFO - Running setup.py (path:/tmp/pip-IHkumq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:09 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)) 06:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:09 INFO - Running setup.py (path:/tmp/pip-XqEsxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:09 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)) 06:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:09 INFO - Running setup.py (path:/tmp/pip-iRD4NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:09 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)) 06:12:09 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)) 06:12:09 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)) 06:12:09 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)) 06:12:09 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)) 06:12:09 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)) 06:12:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:11 INFO - Downloading blessings-1.6.tar.gz 06:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:12:11 INFO - Installing collected packages: blessings 06:12:11 INFO - Running setup.py install for blessings 06:12:11 INFO - Successfully installed blessings 06:12:11 INFO - Cleaning up... 06:12:11 INFO - Return code: 0 06:12:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:12:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:12 INFO - Reading from file tmpfile_stdout 06:12:12 INFO - Current package versions: 06:12:12 INFO - argparse == 1.2.1 06:12:12 INFO - blessings == 1.6 06:12:12 INFO - blobuploader == 1.2.4 06:12:12 INFO - docopt == 0.6.1 06:12:12 INFO - functools32 == 3.2.3-2 06:12:12 INFO - jsonschema == 2.5.1 06:12:12 INFO - manifestparser == 1.1 06:12:12 INFO - mozInstall == 1.12 06:12:12 INFO - mozcrash == 0.17 06:12:12 INFO - mozdebug == 0.1 06:12:12 INFO - mozdevice == 0.48 06:12:12 INFO - mozfile == 1.2 06:12:12 INFO - mozhttpd == 0.7 06:12:12 INFO - mozinfo == 0.9 06:12:12 INFO - mozleak == 0.1 06:12:12 INFO - mozlog == 3.2 06:12:12 INFO - moznetwork == 0.27 06:12:12 INFO - mozprocess == 0.23 06:12:12 INFO - mozprofile == 0.28 06:12:12 INFO - mozrunner == 6.12 06:12:12 INFO - mozscreenshot == 0.1 06:12:12 INFO - mozsystemmonitor == 0.3 06:12:12 INFO - moztest == 0.7 06:12:12 INFO - mozversion == 1.4 06:12:12 INFO - psutil == 3.1.1 06:12:12 INFO - requests == 1.2.3 06:12:12 INFO - wsgiref == 0.1.2 06:12:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12: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')]} 06:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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')]} 06:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:12 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 0x7fe4f6996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, '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': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', '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 06:12:12 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 06:12:12 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 06:12:12 INFO - Using env: {'DISPLAY': ':0', 06:12:12 INFO - 'HOME': '/home/cltbld', 06:12:12 INFO - 'LANG': 'en_US.UTF-8', 06:12:12 INFO - 'LANGUAGE': 'en_US:en', 06:12:12 INFO - 'LOGNAME': 'cltbld', 06:12:12 INFO - 'MAIL': '/var/mail/cltbld', 06:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:12 INFO - 'MOZ_NO_REMOTE': '1', 06:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:12 INFO - 'NO_EM_RESTART': '1', 06:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:12 INFO - 'PWD': '/builds/slave/test', 06:12:12 INFO - 'SHELL': '/bin/bash', 06:12:12 INFO - 'SHLVL': '1', 06:12:12 INFO - 'TERM': 'linux', 06:12:12 INFO - 'TMOUT': '86400', 06:12:12 INFO - 'USER': 'cltbld', 06:12:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:12 INFO - '_': '/tools/buildbot/bin/python'} 06:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:12 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)) 06:12:12 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)) 06:12:12 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)) 06:12:12 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)) 06:12:12 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)) 06:12:12 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)) 06:12:12 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)) 06:12:12 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)) 06:12:12 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)) 06:12:12 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)) 06:12:12 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)) 06:12:12 INFO - Cleaning up... 06:12:12 INFO - Return code: 0 06:12:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:12: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')]} 06:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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')]} 06:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:12 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 0x7fe4f6996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, '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': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', '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 06:12:12 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 06:12:12 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 06:12:12 INFO - Using env: {'DISPLAY': ':0', 06:12:12 INFO - 'HOME': '/home/cltbld', 06:12:12 INFO - 'LANG': 'en_US.UTF-8', 06:12:12 INFO - 'LANGUAGE': 'en_US:en', 06:12:12 INFO - 'LOGNAME': 'cltbld', 06:12:12 INFO - 'MAIL': '/var/mail/cltbld', 06:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:12 INFO - 'MOZ_NO_REMOTE': '1', 06:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:12 INFO - 'NO_EM_RESTART': '1', 06:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:12 INFO - 'PWD': '/builds/slave/test', 06:12:12 INFO - 'SHELL': '/bin/bash', 06:12:12 INFO - 'SHLVL': '1', 06:12:12 INFO - 'TERM': 'linux', 06:12:12 INFO - 'TMOUT': '86400', 06:12:12 INFO - 'USER': 'cltbld', 06:12:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:12 INFO - '_': '/tools/buildbot/bin/python'} 06:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:12:12 INFO - Cleaning up... 06:12:12 INFO - Return code: 0 06:12:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:12: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')]} 06:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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')]} 06:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:12 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 0x7fe4f6996f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, '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': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', '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 06:12:12 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 06:12:12 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 06:12:12 INFO - Using env: {'DISPLAY': ':0', 06:12:12 INFO - 'HOME': '/home/cltbld', 06:12:12 INFO - 'LANG': 'en_US.UTF-8', 06:12:12 INFO - 'LANGUAGE': 'en_US:en', 06:12:12 INFO - 'LOGNAME': 'cltbld', 06:12:12 INFO - 'MAIL': '/var/mail/cltbld', 06:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:12 INFO - 'MOZ_NO_REMOTE': '1', 06:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:12 INFO - 'NO_EM_RESTART': '1', 06:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:12 INFO - 'PWD': '/builds/slave/test', 06:12:12 INFO - 'SHELL': '/bin/bash', 06:12:12 INFO - 'SHLVL': '1', 06:12:12 INFO - 'TERM': 'linux', 06:12:12 INFO - 'TMOUT': '86400', 06:12:12 INFO - 'USER': 'cltbld', 06:12:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:12 INFO - '_': '/tools/buildbot/bin/python'} 06:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:12 INFO - Downloading/unpacking flake8 06:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:12:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:12:14 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 06:12:14 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 06:12:14 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 06:12:14 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 06:12:14 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 06:12:14 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 06:12:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:12:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:12:14 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 06:12:14 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 06:12:14 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 06:12:14 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 06:12:14 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 06:12:14 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 06:12:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:12:15 INFO - no previously-included directories found matching 'docs/_build' 06:12:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:12:15 INFO - Running setup.py install for pep8 06:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:12:15 INFO - no previously-included directories found matching 'docs/_build' 06:12:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:12:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:12:15 INFO - Cleaning up... 06:12:15 INFO - Return code: 0 06:12:15 INFO - Running post-action listener: _resource_record_post_action 06:12:15 INFO - Running post-action listener: _start_resource_monitoring 06:12:15 INFO - Starting resource monitoring. 06:12:15 INFO - ##### 06:12:15 INFO - ##### Finished create-virtualenv step (success) 06:12:15 INFO - ##### 06:12:15 INFO - ##### 06:12:15 INFO - ##### Running install step. 06:12:15 INFO - ##### 06:12:15 INFO - Running pre-action listener: _resource_record_pre_action 06:12:15 INFO - Running main action method: install 06:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:15 INFO - Reading from file tmpfile_stdout 06:12:15 INFO - Detecting whether we're running mozinstall >=1.0... 06:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:12:15 INFO - Reading from file tmpfile_stdout 06:12:15 INFO - Output received: 06:12:15 INFO - Usage: mozinstall [options] installer 06:12:15 INFO - Options: 06:12:15 INFO - -h, --help show this help message and exit 06:12:15 INFO - -d DEST, --destination=DEST 06:12:15 INFO - Directory to install application into. [default: 06:12:15 INFO - "/builds/slave/test"] 06:12:15 INFO - --app=APP Application being installed. [default: firefox] 06:12:15 INFO - mkdir: /builds/slave/test/build/application 06:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:12:31 INFO - Reading from file tmpfile_stdout 06:12:31 INFO - Output received: 06:12:31 INFO - /builds/slave/test/build/application/firefox/firefox 06:12:31 INFO - Running post-action listener: _resource_record_post_action 06:12:31 INFO - ##### 06:12:31 INFO - ##### Finished install step (success) 06:12:31 INFO - ##### 06:12:31 INFO - ##### 06:12:31 INFO - ##### Running run-tests step. 06:12:31 INFO - ##### 06:12:31 INFO - Running pre-action listener: _resource_record_pre_action 06:12:31 INFO - Running main action method: run_tests 06:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:12:31 INFO - Python 2.7.3 06:12:31 INFO - Return code: 0 06:12:31 INFO - grabbing minidump binary from tooltool 06:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:12:31 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27192e0>, '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 0x2685140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26855d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:12:31 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 06:12:31 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 06:12:31 INFO - Calling ['/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'] with output_timeout 600 06:12:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:12:31 INFO - Return code: 0 06:12:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:12:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:12:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:12:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:12:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:12:32 INFO - Return code: 0 06:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 06:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 06:12:32 INFO - Using env: {'DISPLAY': ':0', 06:12:32 INFO - 'HOME': '/home/cltbld', 06:12:32 INFO - 'LANG': 'en_US.UTF-8', 06:12:32 INFO - 'LANGUAGE': 'en_US:en', 06:12:32 INFO - 'LOGNAME': 'cltbld', 06:12:32 INFO - 'MAIL': '/var/mail/cltbld', 06:12:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:12:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:32 INFO - 'MOZ_NO_REMOTE': '1', 06:12:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:32 INFO - 'NO_EM_RESTART': '1', 06:12:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:32 INFO - 'PWD': '/builds/slave/test', 06:12:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:12:32 INFO - 'SHELL': '/bin/bash', 06:12:32 INFO - 'SHLVL': '1', 06:12:32 INFO - 'TERM': 'linux', 06:12:32 INFO - 'TMOUT': '86400', 06:12:32 INFO - 'USER': 'cltbld', 06:12:32 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1468501898.377813-1277435935', 06:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:32 INFO - '_': '/tools/buildbot/bin/python'} 06:12:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 06:12:33 INFO - mozversion application_buildid: 20160714032944 06:12:33 INFO - mozversion application_changeset: 6c4ced3ac243a3e36549904fbe5f889a7a7deaab 06:12:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:12:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:12:33 INFO - mozversion application_name: Firefox 06:12:33 INFO - mozversion application_remotingname: firefox-dev 06:12:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:12:33 INFO - mozversion application_vendor: Mozilla 06:12:33 INFO - mozversion application_version: 49.0a2 06:12:33 INFO - mozversion platform_buildid: 20160714032944 06:12:33 INFO - mozversion platform_changeset: 6c4ced3ac243a3e36549904fbe5f889a7a7deaab 06:12:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:12:33 INFO - mozversion platform_version: 49.0a2 06:12:33 INFO - using testdate: 1468501953 06:12:33 INFO - actual date: 1468501953 06:12:33 INFO - starting webserver on 'localhost:60984' 06:12:33 INFO - SUITE-START | Running 2 tests 06:12:33 INFO - TEST-START | dromaeo_css 06:12:33 INFO - operating with platform_type : linux_ 06:12:33 INFO - Initialising browser for dromaeo_css test... 06:12:33 INFO - TEST-INFO | started process 5670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9xcVgV/profile http://localhost:60984/getInfo.html) 06:12:37 INFO - PROCESS | 5670 | __metrics Screen width/height:1600/1200 06:12:37 INFO - PROCESS | 5670 | colorDepth:24 06:12:37 INFO - PROCESS | 5670 | Browser inner width/height: 1024/697 06:12:37 INFO - PROCESS | 5670 | __metrics 06:12:38 ERROR - PROCESS | 5670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:12:39 INFO - TEST-INFO | 5670: exit 0 06:12:39 INFO - Browser initialized. 06:12:39 INFO - Running cycle 1/1 for dromaeo_css test... 06:12:39 INFO - TEST-INFO | started process 5759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9xcVgV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:51 INFO - PROCESS | 5759 | RSS: Main: 145530880 06:12:51 INFO - PROCESS | 5759 | 06:13:42 INFO - PROCESS | 5759 | 1468502022719 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] 06:15:49 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60984/tests/dromaeo/cssquery-ext.html) 06:15:50 INFO - PROCESS | 5759 | RSS: Main: 242515968 06:15:50 INFO - PROCESS | 5759 | 06:18:53 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-ext.html (next: http://localhost:60984/tests/dromaeo/cssquery-jquery.html) 06:18:53 INFO - PROCESS | 5759 | RSS: Main: 234049536 06:18:53 INFO - PROCESS | 5759 | 06:21:55 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60984/tests/dromaeo/cssquery-mootools.html) 06:21:56 INFO - PROCESS | 5759 | RSS: Main: 214884352 06:21:56 INFO - PROCESS | 5759 | 06:24:58 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60984/tests/dromaeo/cssquery-prototype.html) 06:24:59 INFO - PROCESS | 5759 | RSS: Main: 217182208 06:24:59 INFO - PROCESS | 5759 | 06:28:01 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60984/tests/dromaeo/cssquery-yui.html) 06:28:02 INFO - PROCESS | 5759 | RSS: Main: 217538560 06:28:02 INFO - PROCESS | 5759 | 06:31:04 INFO - PROCESS | 5759 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-yui.html (next: http://localhost:60984/tests/dromaeo/cssquery-dojo.html) 06:31:04 INFO - PROCESS | 5759 | RSS: Main: 263049216 06:31:04 INFO - PROCESS | 5759 | 06:31:04 INFO - PROCESS | 5759 | __start_tp_report 06:31:04 INFO - PROCESS | 5759 | _x_x_mozilla_page_load 06:31:04 INFO - PROCESS | 5759 | _x_x_mozilla_page_load_details 06:31:04 INFO - PROCESS | 5759 | |i|pagename|runs| 06:31:04 INFO - PROCESS | 5759 | |0;dojo.html;3318.3197444523867;3343.9832800835993;3353.6311005789357;3363.125587347289;3388.762786604937;5311.973440132799;5455.590830687699;5503.862403439916;5505.724713764306;5507.421720719327;5407.594430417725;5469.617126801116;5479.2602998595175;5497.697626630534;5505.311836020497;4902.632302577304;4944.678595891264;4969.8012079516775;4989.2017277235645;5036.827505839127;4858.587020103296;4869.805207791684;4876.97561512192;5008.749562521859;5045.4702256262935;4969.105560999037;4984.551390374865;4990.550850423461;4991.600671946236;4992.026554821811;4991.32617096691;5000.7249601271915;5000.774965126578;5002.474740152268;5032.4212715537815;4844.15227335215;4869.074875773592;4881.780319885578;4896.951030489685;4930.457649658535;5355.919661205085;5383.730813459311;5386;5397.217403476513;5401.540869026137;5830.679312637803;5849.532037437038;5855.121731740231;5859.912101318484;5863.2670916135485;5648.802291919763;5784.2769653793275;5813.808169325278;5845.357010728816;5887.146363777271;5557.138643510262;5562.16567514876;5564.888702225973;5567.944320556783;5568.582356323292;6036.758529658764;6040.305364883006;6053.243344581927;6054.878902421927;6060.090986352083;5629.127485239795;5648.322201335866;5691.174779656926;5705.74324155414;5784.652920824764;5827.3007239131575;5862.794802181903;5870.090136028923;5883.146943693226;5883.941160588425;5786.594938354359;5788.797392091256;5799.3040835100055;5804.738786754606;5812.912806307909;5679.914801277984;5698.686572238566;5701.828945131652;5707.971460142756;5794.449527294901;4440.33394990754;4449.7997590108525;4450.265706158512;4452.599266066005;4481.058977614737;4009.599040095967;4014.9761810738073;4024.9798751006056;4035.4955630546183;4065.9390109147794;5560.555155587544;5602.943970560324;5614.775408983595;5639.774409023593;5675.687837168995;5919.852003699942;5937.050071988548;5965.105234214902;5966.850828729316;6014.548908831855;5473.7263136843;5556.861078473071;5577.386487486373;5664.348599911063;5681.545476361881;5089.134847076006;5090.821821236313;5091.719955402488;5094.77073531692;5110.029094472038;6138.7237574309265;6155.045967874987;6163.476104531075;6176.969115154486;6181.690915454209;5697.888911662186;5750.30996280449;5786.189933409242;5897.380775018647;5920.171176035445;6044.24446944132;6086.786962456293;6090.086487026982;6097.847553811191;6141.6007959482495;5730.684812335361;5735.942640573541;5736.799212027559;5738.569607279387;5747.252857128714;5633.0987042073075;5808.448197421239;5811.738471768866;5817.447342502455;5855.092460668603;5694.971525142513;5738.741756621045;5786.884262314646;5788.957987562279;5792.1311803229855;5754.9424505754405;5766.625169363978;5775.306963164448;5775.451332123442;5776.595638305446;5430.565554755531;5452.345718513804;5549.5837812165055;5573.191887176417;5678.602497825113;5746.798862039808;5757.510611598061;5778.335491418541;5782.855428614318;5786.016377215968;5625.662460252398;5625.887482250414;5627;5629.043062679272;5644.8024319148635 06:31:04 INFO - PROCESS | 5759 | |1;ext.html;587.6063037764698;646.218076127885;655.5083687234574;659.2583343738295;662.6752891083371;32870.17824554387;44005;44813;44915.55084449155;44991;47581;47875.28187077196;48016;48019.519804801945;48130.27804582934;8204.138565450632;8887.64449422024;9038.18656320931;9062.093790620951;10541.84187237192;10370;10788.190885683605;10791.892081079206;10795.08241799448;10799.352038877652;10830.079443247334;10877.292975956578;10878.945605271963;10880.12958963281;10885.782284354347;8258.339332853357;8430.494170349737;10584.31201971877;10802.783944321109;10824.891751082467;10402;10424.94787526065;10426.113780328682;10429.634962776267;10435.269531132824;43700;43841.34237986433;43928.56071439277;43945.560544394786;44126.779366102965;3462.342154990544;3501.0197144799495;3733.9439908401396;3738.1776009277914;4312.892177695583;33287.16782080467;35868.10329741751;36274.8186259067;37615.24769504622;37632;4726.865113961888;4728.40894888139;4729.905401891943;4828.8652166740785;4972.105021096201;394413;398980;400000;400421;402439.98780006205;39096.60903390987;40256.59743402587;71154.64422677956;72075.2792472079;72204.63897680478;41671.374929376085;41714.16571668549;41819.7909010453;41908.58091419108;41914.37128443076;17835;18163.909180454277;18169.63660726778;18180.272789088554;18183.45449636513;13788.862111378958;14797.186154761375;15059.021163624548;15075.396984120513;15389.307481163374;9415.387999779992;9435.622575097057;9480.952595237117;9523.857142142873;9587.328886977984;3628.38317486028;3631.7276204284785;3654.5797233317976;3666.138457462494;3719.776813391205;994.557421947241;1010.939343639384;1053.8103141434615;1142.3831131189231;1151.1423989128152;34439.87343354013;34799.82600087034;34842.30315393729;34881.30237395289;34963.47554786629;1034.6585626743156;1092.1426680056118;1173.7769823733463;1230.267990545624;1234.160770675949;17410.21654025572;17893.37373191932;18038.36865709694;18089.36687215941;18147.27410903549;681714;683451;686288;689085;689742;63018.36981630217;64135.67932160309;64373.35626643767;64581.67709161518;64592;1298.558490113366;1394.6095093373872;1397.5457976157788;1398.286873694423;1403.1651167555492;33755.66244337623;34716.30567388688;35295.34981147958;35341.51400794803;35698;54585.72707136439;59743;61256.38743612507;61305;66061;590026;596891;599368;600222;601182;40875.386869196394;41876;41895.581044189166;44503.55496444994;46450.30324545202;49069.509304906496;52526.21210681919;52696.473035269155;53020.46979530156;53406.73296633492;41002.79498602607;43043.7847810759;43730.562694372646;43972.34041489444;44349.33475997798;42350.36474452947;42917.78541107274;43049.56950430581;43432;43838.34242486302;42304.365434517895;42925.570744292156;43381.13237735291;43877.12245755003;44203;37667.623323767504;38107.42838857364;38403;38518.42222366723;38864;28713.85643071771;29130.854345728985;29177.562336565392;29396.706032939397;29519.26201844971 06:31:04 INFO - PROCESS | 5759 | |2;jquery.html;429.3004956112129;430.04529943525364;431.8553284649643;440.4142490487651;444.04087171709114;19717.50706232343;19824.504387390323;20606.587868242663;20679;20762.896185519072;19347.516312092168;19537.218511259533;19804.70292945607;19835.801641983577;19855.30506432275;5541.833744987647;5777.902198582277;5808.477237048664;5808.796692115777;5809.564282678795;5848.415158484138;5861.706914654272;5910.024845900442;5912.615679980809;5918.437748413894;5859.7656093756195;5862.912056319137;5863.76544938202;5866.5306775458075;5882.6764527950945;5755.338136114337;5804.448577385142;6064.151018857364;6070.908936365936;6153.784617538365;5734.569907256972;5926.348101708809;5926.614770039933;5930.377310382434;5944.554158438134;22523.774762252495;22585.54828903429;22897.77102228973;23243.53512929732;23301.3009609712;2299.1837897546297;2461.003293666068;2480.379905023744;2614.660094187743;3068.3556453144865;10204.846927296096;10393.428361440117;10447.42539160346;10719.464026798629;10901.781964360669;1910.8757930734457;2002.5594369238745;2039.1129858511595;2051.2820512820545;2064.8554601177925;61893;65307;72962;75376.62311688461;78849.60575197087;10417.739556510996;11485.598004069818;11508.59719909799;11710;11762.35307058103;14986.40054397812;15195.164265965257;15770.526884193263;15800.89393742427;15866.286017129027;7040.753573624898;8340.958295208486;9040.141186587263;9192.034836342087;9265.397749146285;9111.772205694779;9133.315001374924;9150.267978561833;9261.72214833556;9263.212626926652;4736.881577960578;4941.579965702884;5090.516400941905;5141.475163470226;5168.457311982188;2102.8317734581196;2123.872567645946;2131.504332894055;2131.9573608527744;2203.460152262674;458.2942268905914;502.8717676992417;1013.9695809125737;1024.7088668277875;1075.8386242063752;12009.219400738924;12263.632091037283;12348;12486.12597118193;12494.250344979331;491.3049977577372;500.0474096845515;510.0233053702193;511.0673021735348;519.2496842063258;6678.131842860397;6701.1288532491435;6720.0255962886085;6733.494987875929;6738.494612904052;452357;467534;484962.6747141039;490181;493528;99579.50210249047;99756;100930;101282;101416.49291753494;513.3429210610425;522.3261992030239;522.9346331708537;523.353658232083;525.3957948359417;11368.715782105513;11474;11515.769684606428;11601.535938562363;11721.179517434039;31299;35725.46411803877;40967.795161024005;41558.79220603999;42414.57585424106;53921;56662.7166864163;57018;58190.709046454496;60613.393866060775;8117.512949223065;8314.708985185489;8456.027556831043;8532;9026.142516460926;9833.16418104469;12884.871151288367;13096.934515327363;13125;13921.860781392461;9065.456072635663;11174.664760056887;11722.648320550397;11860.169788114748;12163.878361216628;11675.065994720571;11924.642260732191;11974.700632484257;12478.812817807922;12609.243445393306;11605.825912611486;11642.5342986283;11668.474918628512;11774.705632359259;12002.21985570935;7759.4568380215105;7912.4856884302335;8355.41512094172;8454.985401751828;8481.491110533389;11544.711382215175;11690.415479226174;11690.532378704756;11942.582009629621;11998.220115692453 06:31:04 INFO - PROCESS | 5759 | |3;mootools.html;1408.6619211389257;1578.1241411016888;1590.340008896308;1821.2532861526777;1927.5566619677475;8451.28164106051;8820;8851;8991;9003.684871029514;8784.604692788824;8937.55312234389;8945.373823832335;8954.597043133059;8961.238294744955;2126.840486963476;2402.3513651314133;2410.590199666061;2459.1270099114827;2478.5538603051446;2434.4644178280837;2456.238566044523;2458.0045081741832;2466.087547607379;2470.2465747946867;2424.73327933928;2440.1093600835657;2440.9267721968367;2447.437089469423;2449.301948944551;2071.8860462674547;2357.5992081346126;2408.229366602688;2436.8294219404647;2442.792362649177;2447.5349683560066;2474.7030356357172;2475.207933461293;2491.576432006545;2523.2934778262115;9258.861117083181;9320.813583728355;9334.71995840126;9341.019192984775;9342.859857102148;5421.83734487966;5554.361248456398;5561.054620714488;5563.610547261694;5564.248826408423;3409.4715319125576;3439.793612383265;3503.737219708532;3594.8741794037346;3618.1135621772833;1154.613204576468;1216.4829947272374;1225.5526732742485;2076.6262072826885;2123.1401282480465;13275.203487790666;13489.86510134896;13520.526781562696;13539.119957202849;13542.322883855866;4795.184818580849;4916.655834091651;4959.776810043557;4979.975100124476;4991.925121123186;11345.716357091138;11358.034567061892;11399;11405.486753095965;11414.714632134263;4960.355153829979;5682.943170568324;5685.715714214272;5686.232358631614;5693.743781529841;4958.752062396866;5124.564412024945;5134.666246693953;5152.175651895679;5160.819371322061;4317.8272869084885;4323.524412314643;4353.085851971122;4468.262736648417;4482.843100491467;1327.4955516903708;1336.2784096587927;1344.3009634989946;1345.3138899161302;1375.6698392385756;1059.8887116852773;1064;1066.0618655583037;1070.7751372211924;1071.7106381277013;6265.530085243625;6339.2392912850755;6434.292227854932;6439.484841212692;6515.73937042513;511.34037092151453;516.318459633288;1080.5623722392443;1095.4030053620795;1108.728361551425;4311.33174357975;4331.805068771912;4348.326009468537;4389.912201755947;4401.625861801783;11580;11927.807219278002;12016.218945768496;12017.218880772722;12040.277583345027;11200.327980321206;11712.180147389601;11746.941265293619;11911.463984120735;11984.58053968107;8730.86903696445;8794.032656407919;8845.734627961043;8859.7342079739;8868.600912958933;6405.231372235362;6609.669516524058;6680.131582894387;6687.866242675022;6728.05807187004;10106.19150467946;10464.110550603284;10940.781184376427;11091.778164436504;11114.277571957797;10391.532381043022;10732.356058636507;10752.193585480964;10754.838677419688;10854.34873907568;7509.4367922404945;8058.435909486279;8246.216609422096;8459.365547584079;8635.179657932485;8900.955495222483;8964.058773828914;8980.326475514232;8985.730428087169;8997.235235004837;7966.721164759438;8104.8784268237205;8134.186581341818;8155.347572194329;8280.792980175303;7980.4812687175145;8146.307563857138;8151.103378628228;8274.751757447286;8300.875486867822;7143.321384468467;7339.669714862737;7375.041244638162;7380.261973802577;7415.925840741524;5447.400785913625;5465.9614673213555;5545.223668686306;5588.245586845724;5696.458836410535;5452.781888724565;5528.281323427928;5641.746121424628;5653.123765816305;5707.600467967369 06:31:04 INFO - PROCESS | 5759 | |4;prototype.html;347.6280379993408;355.35503061942575;356.7787971457695;359.7463788029439;363.13392558747387;5237.214417837326;5367.543758780508;5431.972840135799;5449.9835061027425;5471.91792123118;5405.810796622119;5452.6455780374245;5455.509004189622;5466.34403871535;5473.397926228122;4289.957100429003;4297.269464191079;4304.117655880537;4315.762633055181;4333.8699839004885;4039.6162364575466;4120.814563344657;4214.6838987075935;4303.419038429819;4331;4224.809883555247;4225.957740422603;4235.555266696999;4242.5999420191265;4248.97875510622;4209.326507758744;4236.343366778155;4244.214820258262;4259.700791258665;4295.828166873322;3712.2389910068373;3786.7917264550438;3841.154945911895;3843.385058390644;3846.480725102131;5190.59853839465;5214.878801057753;5222.843314700565;5245.895082098375;5248.270899132468;4847.321375007502;4858.344123543312;4866.245731911559;4889.144399730033;4918.2376731606655;5509.559235261169;5613.747381367848;5619;5646.57650676201;5648.802291919804;4144.585541445861;4152.688548358885;4154.127633197032;4176.644985176264;4188.979055104735;5745.770169193227;5799.129430931674;5802.738876750556;5895.469407753323;5903.468687818074;4199.916001680011;4287.8499252526635;4302.892427689333;4310.4180935573295;4311.741295522279;4290.399344091829;4320.78396080201;4324.221640104748;4335.328024156198;4368.340030788344;4879.975600122048;4889.608831293488;4898.314236006961;4904.362432883702;4943.9258411123865;5549.112142057332;5652.547796176296;5660.349059858087;5692.6299790513485;5715.228444160069;1416.482983710938;1446.5154173351834;1491.142593009024;1498.9625259368604;1500.4598344595936;967.6613185385199;977.9168770654574;989.5992123190119;995.581855620641;1006.7785087280787;4838.346823178897;4909.87725306863;4939.185034469272;4947.975260123676;4969.254611808257;5144.845654630367;5170.242117680007;5204.739763011834;5223.145783246969;5224.791008359623;4723.338732577442;4947.1837146871085;4980.327655766425;4988.301637770715;5003.949960500421;2755.931101722473;2756.379814541712;2783.582462630581;2788.888444462199;2806.2984253936515;5339.733013349394;5379.865503362447;5396.892062158735;5399.1091469907815;5413.675179489243;5154;5205.73971301441;5587.413321601173;5977.252843394575;5989.35292794485;6134.877302453926;6143.846403839851;6164;6174.8147555573405;6183.227096612924;5640.379558248672;5879.735411906389;5884.58807883444;5919.171316015675;5942.554308426799;5770.480656740913;5773.874094551522;5780.335261444988;5836.591438599427;5865.413458654271;6093.421124993119;6101.267847858286;6120.387961203844;6121.510279177744;6153.784617538365;4104.404861295156;4161.292580261424;4185.142045880648;4191.97904010478;4209.810558524935;5610.831675049755;5745.942540574708;5830.854228644318;5843.1235314703135;5866.266716660418;5609.607327487037;5611.971940140274;5627.803026894039;5659.9151012735665;5704.318970084054;5690.971545142248;5728.369879313189;5735.827925162252;5737.454941780524;5739.62692424991;5505.339359276913;5568.303962004749;5611.971940140274;5614.242077319673;5650.886982260414;5718.542516598745;5729.1119876419225;5789.797357092481;5802.47777700009;5837;5349.037173308841;5590.211132437581;5623.971880140737;5652.463016013472;5684.7157642118555 06:31:04 INFO - PROCESS | 5759 | |5;yui.html;769.4921351907739;779.2674885607529;783.1502819440906;851.8168593752343;900.2887718702226;16348.100854453016;16516.339346426128;17206.483805485823;17262.223199956;17282.740758888613;14838;14991.250437478137;15004;15007.099574025538;15025.849741502581;726.1649103530929;861.5132450165668;877.2850127146371;887.8313120507083;891.61660485991;887.1040249348173;889.9644014239454;890.1587999340626;890.5992303463435;892.995535022324;932.4591736792644;932.6968735161066;934.3833070173687;934.6541779541545;935.050923312838;773.1958762886591;908.5593487158723;932.6549176804558;932.9860052099224;936.4381371177308;685.4173952140691;686.0087174033523;686.2485578291812;686.4234043403515;687.041577000087;15939.681206375924;16001.119938403383;16006.839931600767;16032.438864639682;16038.75941860873;15623.140727259995;15708.450204242796;15760.2119894006;15965.920170399073;16019.759703604455;13476.730465390736;13700.725985480234;13721.931390342985;13959.511417100353;14263.928680356532;4699.765011749433;4718.646101542398;4732.1482133216;4740.691855029412;4862.708237505761;75423.62288188579;76919.23080769232;77024;77422.61288693521;77912;11745.236559623598;11984.161108722481;12364.258144511357;12405.069619778373;12584.81122783159;22205.888970555043;22435.43911402228;22439.43901402478;22462.438439039153;22514.774852251594;7955.681772729026;8463.830723385498;8559.058503564604;8755;9183.494907780003;4894.1679914414635;5014.598832093424;5180.585553155738;5229.869253268623;5384.5692344612335;3898.434726964574;4049.8380064797666;4052.3111071117983;4052.5339585947404;4055.371417430303;671.9160104986877;673.845015646404;675.6351570152161;687.3229868579446;691.0463560286772;783.902012248469;784.5175217241356;789.4158322841056;802.8093352698902;806.3025482957199;10818.404987725593;10872;11037.724056898642;11148.609798657008;11162.162837787198;743.687651186503;800.3877034068942;824.2746383182881;830.779843341515;833.6332013913858;4956.157453232959;5074.822381216713;5163.380394352702;5286.577073834084;5411.134218525017;68744.65627671829;113583.4320828407;115519.42240288745;115900;116432.41783791197;68301.31698683048;87377.1262287369;96302;101189.49405252926;102318.48840755898;60096.098558521655;78179.99999999886;92575.53712231395;93978;94012;10712.625058122929;10870.836937445787;10976.560937562728;11157.386343750846;11205.88794112081;51677.48322516727;52076;52424.47575524196;52510;53201.7339913298;68477.65761171162;70059;73447;76853.61573192099;78801.21198787939;13662.726745464835;14003.719925601634;14293.213873237071;14572.125672459686;14952.850471495145;16240.269187886337;16302.67394652124;16338.836611633731;16667.16664166811;17019.914900425418;13444.296471589943;13585.388657510633;13814.447422103405;15795.842041579897;16043.679126417639;14926.68824932915;14963;14985.625359365667;15287.923560382127;15770.605734856721;12448.190867593577;12789.680257993252;13149.802752958522;13363.599092027254;14198.858011419754;10842.966335019768;11009.669709908716;11231.66305010851;11319.660410187707;11416.94291528537;11899.702507437383;11997.700057498632;12200.14598978063;12276.938615306866;12477.438515266653 06:31:04 INFO - PROCESS | 5759 | __end_tp_report 06:31:04 INFO - PROCESS | 5759 | __start_cc_report 06:31:04 INFO - PROCESS | 5759 | _x_x_mozilla_cycle_collect,809 06:31:04 INFO - PROCESS | 5759 | __end_cc_report 06:31:04 INFO - PROCESS | 5759 | __startTimestamp1468503064955__endTimestamp 06:31:04 INFO - PROCESS | 5759 | 06:31:04 INFO - PROCESS | 5759 | ------- Summary: start ------- 06:31:04 INFO - PROCESS | 5759 | Number of tests: 6 06:31:04 INFO - PROCESS | 5759 | 06:31:04 INFO - PROCESS | 5759 | [#0] dojo.html Cycles:165 Average:5441.92 Median:5644.80 stddev:599.74 (10.6%) stddev-sans-first:577.98 06:31:04 INFO - PROCESS | 5759 | Values: 3318.3 3344.0 3353.6 3363.1 3388.8 5312.0 5455.6 5503.9 5505.7 5507.4 5407.6 5469.6 5479.3 5497.7 5505.3 4902.6 4944.7 4969.8 4989.2 5036.8 4858.6 4869.8 4877.0 5008.7 5045.5 4969.1 4984.6 4990.6 4991.6 4992.0 4991.3 5000.7 5000.8 5002.5 5032.4 4844.2 4869.1 4881.8 4897.0 4930.5 5355.9 5383.7 5386.0 5397.2 5401.5 5830.7 5849.5 5855.1 5859.9 5863.3 5648.8 5784.3 5813.8 5845.4 5887.1 5557.1 5562.2 5564.9 5567.9 5568.6 6036.8 6040.3 6053.2 6054.9 6060.1 5629.1 5648.3 5691.2 5705.7 5784.7 5827.3 5862.8 5870.1 5883.1 5883.9 5786.6 5788.8 5799.3 5804.7 5812.9 5679.9 5698.7 5701.8 5708.0 5794.4 4440.3 4449.8 4450.3 4452.6 4481.1 4009.6 4015.0 4025.0 4035.5 4065.9 5560.6 5602.9 5614.8 5639.8 5675.7 5919.9 5937.1 5965.1 5966.9 6014.5 5473.7 5556.9 5577.4 5664.3 5681.5 5089.1 5090.8 5091.7 5094.8 5110.0 6138.7 6155.0 6163.5 6177.0 6181.7 5697.9 5750.3 5786.2 5897.4 5920.2 6044.2 6086.8 6090.1 6097.8 6141.6 5730.7 5735.9 5736.8 5738.6 5747.3 5633.1 5808.4 5811.7 5817.4 5855.1 5695.0 5738.7 5786.9 5789.0 5792.1 5754.9 5766.6 5775.3 5775.5 5776.6 5430.6 5452.3 5549.6 5573.2 5678.6 5746.8 5757.5 5778.3 5782.9 5786.0 5625.7 5625.9 5627.0 5629.0 5644.8 06:31:04 INFO - PROCESS | 5759 | 06:31:04 INFO - PROCESS | 5759 | [#1] ext.html Cycles:180 Average:71347.93 Median:40939.09 stddev:153269.67 (374.4%) stddev-sans-first:153607.55 06:31:04 INFO - PROCESS | 5759 | Values: 587.6 646.2 655.5 659.3 662.7 32870.2 44005.0 44813.0 44915.6 44991.0 47581.0 47875.3 48016.0 48019.5 48130.3 8204.1 8887.6 9038.2 9062.1 10541.8 10370.0 10788.2 10791.9 10795.1 10799.4 10830.1 10877.3 10878.9 10880.1 10885.8 8258.3 8430.5 10584.3 10802.8 10824.9 10402.0 10424.9 10426.1 10429.6 10435.3 43700.0 43841.3 43928.6 43945.6 44126.8 3462.3 3501.0 3733.9 3738.2 4312.9 33287.2 35868.1 36274.8 37615.2 37632.0 4726.9 4728.4 4729.9 4828.9 4972.1 394413.0 398980.0 400000.0 400421.0 402440.0 39096.6 40256.6 71154.6 72075.3 72204.6 41671.4 41714.2 41819.8 41908.6 41914.4 17835.0 18163.9 18169.6 18180.3 18183.5 13788.9 14797.2 15059.0 15075.4 15389.3 9415.4 9435.6 9481.0 9523.9 9587.3 3628.4 3631.7 3654.6 3666.1 3719.8 994.6 1010.9 1053.8 1142.4 1151.1 34439.9 34799.8 34842.3 34881.3 34963.5 1034.7 1092.1 1173.8 1230.3 1234.2 17410.2 17893.4 18038.4 18089.4 18147.3 681714.0 683451.0 686288.0 689085.0 689742.0 63018.4 64135.7 64373.4 64581.7 64592.0 1298.6 1394.6 1397.5 1398.3 1403.2 33755.7 34716.3 35295.3 35341.5 35698.0 54585.7 59743.0 61256.4 61305.0 66061.0 590026.0 596891.0 599368.0 600222.0 601182.0 40875.4 41876.0 41895.6 44503.6 46450.3 49069.5 52526.2 52696.5 53020.5 53406.7 41002.8 43043.8 43730.6 43972.3 44349.3 42350.4 42917.8 43049.6 43432.0 43838.3 42304.4 42925.6 43381.1 43877.1 44203.0 37667.6 38107.4 38403.0 38518.4 38864.0 28713.9 29130.9 29177.6 29396.7 29519.3 06:31:04 INFO - PROCESS | 5759 | 06:31:04 INFO - PROCESS | 5759 | [#2] jquery.html Cycles:180 Average:28139.52 Median:430.95 stddev:78971.27 (18324.9%) stddev-sans-first:79165.40 06:31:04 INFO - PROCESS | 5759 | Values: 429.3 430.0 431.9 440.4 444.0 19717.5 19824.5 20606.6 20679.0 20762.9 19347.5 19537.2 19804.7 19835.8 19855.3 5541.8 5777.9 5808.5 5808.8 5809.6 5848.4 5861.7 5910.0 5912.6 5918.4 5859.8 5862.9 5863.8 5866.5 5882.7 5755.3 5804.4 6064.2 6070.9 6153.8 5734.6 5926.3 5926.6 5930.4 5944.6 22523.8 22585.5 22897.8 23243.5 23301.3 2299.2 2461.0 2480.4 2614.7 3068.4 10204.8 10393.4 10447.4 10719.5 10901.8 1910.9 2002.6 2039.1 2051.3 2064.9 61893.0 65307.0 72962.0 75376.6 78849.6 10417.7 11485.6 11508.6 11710.0 11762.4 14986.4 15195.2 15770.5 15800.9 15866.3 7040.8 8341.0 9040.1 9192.0 9265.4 9111.8 9133.3 9150.3 9261.7 9263.2 4736.9 4941.6 5090.5 5141.5 5168.5 2102.8 2123.9 2131.5 2132.0 2203.5 458.3 502.9 1014.0 1024.7 1075.8 12009.2 12263.6 12348.0 12486.1 12494.3 491.3 500.0 510.0 511.1 519.2 6678.1 6701.1 6720.0 6733.5 6738.5 452357.0 467534.0 484962.7 490181.0 493528.0 99579.5 99756.0 100930.0 101282.0 101416.5 513.3 522.3 522.9 523.4 525.4 11368.7 11474.0 11515.8 11601.5 11721.2 31299.0 35725.5 40967.8 41558.8 42414.6 53921.0 56662.7 57018.0 58190.7 60613.4 8117.5 8314.7 8456.0 8532.0 9026.1 9833.2 12884.9 13096.9 13125.0 13921.9 9065.5 11174.7 11722.6 11860.2 12163.9 11675.1 11924.6 11974.7 12478.8 12609.2 11605.8 11642.5 11668.5 11774.7 12002.2 7759.5 7912.5 8355.4 8455.0 8481.5 11544.7 11690.4 11690.5 11942.6 11998.2 06:31:04 INFO - PROCESS | 5759 | 06:31:04 INFO - PROCESS | 5759 | [#3] mootools.html Cycles:180 Average:6186.55 Median:4434.94 stddev:3531.96 (79.6%) stddev-sans-first:3523.61 06:31:04 INFO - PROCESS | 5759 | Values: 1408.7 1578.1 1590.3 1821.3 1927.6 8451.3 8820.0 8851.0 8991.0 9003.7 8784.6 8937.6 8945.4 8954.6 8961.2 2126.8 2402.4 2410.6 2459.1 2478.6 2434.5 2456.2 2458.0 2466.1 2470.2 2424.7 2440.1 2440.9 2447.4 2449.3 2071.9 2357.6 2408.2 2436.8 2442.8 2447.5 2474.7 2475.2 2491.6 2523.3 9258.9 9320.8 9334.7 9341.0 9342.9 5421.8 5554.4 5561.1 5563.6 5564.2 3409.5 3439.8 3503.7 3594.9 3618.1 1154.6 1216.5 1225.6 2076.6 2123.1 13275.2 13489.9 13520.5 13539.1 13542.3 4795.2 4916.7 4959.8 4980.0 4991.9 11345.7 11358.0 11399.0 11405.5 11414.7 4960.4 5682.9 5685.7 5686.2 5693.7 4958.8 5124.6 5134.7 5152.2 5160.8 4317.8 4323.5 4353.1 4468.3 4482.8 1327.5 1336.3 1344.3 1345.3 1375.7 1059.9 1064.0 1066.1 1070.8 1071.7 6265.5 6339.2 6434.3 6439.5 6515.7 511.3 516.3 1080.6 1095.4 1108.7 4311.3 4331.8 4348.3 4389.9 4401.6 11580.0 11927.8 12016.2 12017.2 12040.3 11200.3 11712.2 11746.9 11911.5 11984.6 8730.9 8794.0 8845.7 8859.7 8868.6 6405.2 6609.7 6680.1 6687.9 6728.1 10106.2 10464.1 10940.8 11091.8 11114.3 10391.5 10732.4 10752.2 10754.8 10854.3 7509.4 8058.4 8246.2 8459.4 8635.2 8901.0 8964.1 8980.3 8985.7 8997.2 7966.7 8104.9 8134.2 8155.3 8280.8 7980.5 8146.3 8151.1 8274.8 8300.9 7143.3 7339.7 7375.0 7380.3 7415.9 5447.4 5466.0 5545.2 5588.2 5696.5 5452.8 5528.3 5641.7 5653.1 5707.6 06:31:04 INFO - PROCESS | 5759 | 06:31:04 INFO - PROCESS | 5759 | [#4] prototype.html Cycles:180 Average:4731.05 Median:5231.00 stddev:1378.02 (26.3%) stddev-sans-first:1342.04 06:31:04 INFO - PROCESS | 5759 | Values: 347.6 355.4 356.8 359.7 363.1 5237.2 5367.5 5432.0 5450.0 5471.9 5405.8 5452.6 5455.5 5466.3 5473.4 4290.0 4297.3 4304.1 4315.8 4333.9 4039.6 4120.8 4214.7 4303.4 4331.0 4224.8 4226.0 4235.6 4242.6 4249.0 4209.3 4236.3 4244.2 4259.7 4295.8 3712.2 3786.8 3841.2 3843.4 3846.5 5190.6 5214.9 5222.8 5245.9 5248.3 4847.3 4858.3 4866.2 4889.1 4918.2 5509.6 5613.7 5619.0 5646.6 5648.8 4144.6 4152.7 4154.1 4176.6 4189.0 5745.8 5799.1 5802.7 5895.5 5903.5 4199.9 4287.8 4302.9 4310.4 4311.7 4290.4 4320.8 4324.2 4335.3 4368.3 4880.0 4889.6 4898.3 4904.4 4943.9 5549.1 5652.5 5660.3 5692.6 5715.2 1416.5 1446.5 1491.1 1499.0 1500.5 967.7 977.9 989.6 995.6 1006.8 4838.3 4909.9 4939.2 4948.0 4969.3 5144.8 5170.2 5204.7 5223.1 5224.8 4723.3 4947.2 4980.3 4988.3 5003.9 2755.9 2756.4 2783.6 2788.9 2806.3 5339.7 5379.9 5396.9 5399.1 5413.7 5154.0 5205.7 5587.4 5977.3 5989.4 6134.9 6143.8 6164.0 6174.8 6183.2 5640.4 5879.7 5884.6 5919.2 5942.6 5770.5 5773.9 5780.3 5836.6 5865.4 6093.4 6101.3 6120.4 6121.5 6153.8 4104.4 4161.3 4185.1 4192.0 4209.8 5610.8 5745.9 5830.9 5843.1 5866.3 5609.6 5612.0 5627.8 5659.9 5704.3 5691.0 5728.4 5735.8 5737.5 5739.6 5505.3 5568.3 5612.0 5614.2 5650.9 5718.5 5729.1 5789.8 5802.5 5837.0 5349.0 5590.2 5624.0 5652.5 5684.7 06:31:04 INFO - PROCESS | 5759 | 06:31:04 INFO - PROCESS | 5759 | [#5] yui.html Cycles:180 Average:20833.20 Median:4377.57 stddev:28629.84 (654.0%) stddev-sans-first:28670.52 06:31:04 INFO - PROCESS | 5759 | Values: 769.5 779.3 783.2 851.8 900.3 16348.1 16516.3 17206.5 17262.2 17282.7 14838.0 14991.3 15004.0 15007.1 15025.8 726.2 861.5 877.3 887.8 891.6 887.1 890.0 890.2 890.6 893.0 932.5 932.7 934.4 934.7 935.1 773.2 908.6 932.7 933.0 936.4 685.4 686.0 686.2 686.4 687.0 15939.7 16001.1 16006.8 16032.4 16038.8 15623.1 15708.5 15760.2 15965.9 16019.8 13476.7 13700.7 13721.9 13959.5 14263.9 4699.8 4718.6 4732.1 4740.7 4862.7 75423.6 76919.2 77024.0 77422.6 77912.0 11745.2 11984.2 12364.3 12405.1 12584.8 22205.9 22435.4 22439.4 22462.4 22514.8 7955.7 8463.8 8559.1 8755.0 9183.5 4894.2 5014.6 5180.6 5229.9 5384.6 3898.4 4049.8 4052.3 4052.5 4055.4 671.9 673.8 675.6 687.3 691.0 783.9 784.5 789.4 802.8 806.3 10818.4 10872.0 11037.7 11148.6 11162.2 743.7 800.4 824.3 830.8 833.6 4956.2 5074.8 5163.4 5286.6 5411.1 68744.7 113583.4 115519.4 115900.0 116432.4 68301.3 87377.1 96302.0 101189.5 102318.5 60096.1 78180.0 92575.5 93978.0 94012.0 10712.6 10870.8 10976.6 11157.4 11205.9 51677.5 52076.0 52424.5 52510.0 53201.7 68477.7 70059.0 73447.0 76853.6 78801.2 13662.7 14003.7 14293.2 14572.1 14952.9 16240.3 16302.7 16338.8 16667.2 17019.9 13444.3 13585.4 13814.4 15795.8 16043.7 14926.7 14963.0 14985.6 15287.9 15770.6 12448.2 12789.7 13149.8 13363.6 14198.9 10843.0 11009.7 11231.7 11319.7 11416.9 11899.7 11997.7 12200.1 12276.9 12477.4 06:31:04 INFO - PROCESS | 5759 | -------- Summary: end -------- 06:31:04 INFO - PROCESS | 5759 | 06:31:05 INFO - TEST-INFO | 5759: exit 0 06:31:05 INFO - TEST-OK | dromaeo_css | took 1112553ms 06:31:05 INFO - TEST-START | kraken 06:31:05 INFO - operating with platform_type : linux_ 06:31:05 INFO - Initialising browser for kraken test... 06:31:05 INFO - TEST-INFO | started process 5953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpINlw5U/profile http://localhost:60984/getInfo.html) 06:31:09 INFO - PROCESS | 5953 | __metrics Screen width/height:1600/1200 06:31:09 INFO - PROCESS | 5953 | colorDepth:24 06:31:09 INFO - PROCESS | 5953 | Browser inner width/height: 1024/697 06:31:09 INFO - PROCESS | 5953 | __metrics 06:31:10 ERROR - PROCESS | 5953 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:31:11 INFO - TEST-INFO | 5953: exit 0 06:31:11 INFO - Browser initialized. 06:31:11 INFO - Running cycle 1/1 for kraken test... 06:31:11 INFO - TEST-INFO | started process 6048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpINlw5U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:23 INFO - PROCESS | 6048 | RSS: Main: 145313792 06:31:23 INFO - PROCESS | 6048 | 06:31:26 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60984/tests/kraken/driver.html?testName=audio-beat-detection) 06:31:26 INFO - PROCESS | 6048 | RSS: Main: 195149824 06:31:26 INFO - PROCESS | 6048 | 06:31:29 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60984/tests/kraken/driver.html?testName=audio-dft) 06:31:30 INFO - PROCESS | 6048 | RSS: Main: 193093632 06:31:30 INFO - PROCESS | 6048 | 06:31:32 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60984/tests/kraken/driver.html?testName=audio-fft) 06:31:33 INFO - PROCESS | 6048 | RSS: Main: 278626304 06:31:33 INFO - PROCESS | 6048 | 06:31:35 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60984/tests/kraken/driver.html?testName=audio-oscillator) 06:31:36 INFO - PROCESS | 6048 | RSS: Main: 187453440 06:31:36 INFO - PROCESS | 6048 | 06:31:38 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60984/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:31:38 INFO - PROCESS | 6048 | RSS: Main: 188436480 06:31:38 INFO - PROCESS | 6048 | 06:31:41 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60984/tests/kraken/driver.html?testName=imaging-darkroom) 06:31:42 INFO - PROCESS | 6048 | RSS: Main: 222814208 06:31:42 INFO - PROCESS | 6048 | 06:31:45 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60984/tests/kraken/driver.html?testName=imaging-desaturate) 06:31:46 INFO - PROCESS | 6048 | RSS: Main: 222441472 06:31:46 INFO - PROCESS | 6048 | 06:31:49 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60984/tests/kraken/driver.html?testName=json-parse-financial) 06:31:49 INFO - PROCESS | 6048 | RSS: Main: 221929472 06:31:49 INFO - PROCESS | 6048 | 06:31:51 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60984/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:31:51 INFO - PROCESS | 6048 | RSS: Main: 201334784 06:31:51 INFO - PROCESS | 6048 | 06:31:53 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:31:54 INFO - PROCESS | 6048 | RSS: Main: 200003584 06:31:54 INFO - PROCESS | 6048 | 06:31:56 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:31:56 INFO - PROCESS | 6048 | RSS: Main: 208408576 06:31:56 INFO - PROCESS | 6048 | 06:31:59 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:32:00 INFO - PROCESS | 6048 | RSS: Main: 216637440 06:32:00 INFO - PROCESS | 6048 | 06:32:02 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:32:03 INFO - PROCESS | 6048 | RSS: Main: 218095616 06:32:03 INFO - PROCESS | 6048 | 06:32:04 INFO - PROCESS | 6048 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60984/tests/kraken/driver.html?testName=ai-astar) 06:32:05 INFO - PROCESS | 6048 | RSS: Main: 260100096 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | __start_tp_report 06:32:05 INFO - PROCESS | 6048 | _x_x_mozilla_page_load 06:32:05 INFO - PROCESS | 6048 | _x_x_mozilla_page_load_details 06:32:05 INFO - PROCESS | 6048 | |i|pagename|runs| 06:32:05 INFO - PROCESS | 6048 | |0;ai-astar;109;104;109;109;111;109;110;110;109;108 06:32:05 INFO - PROCESS | 6048 | |1;audio-beat-detection;159;130;126;169;124;124;145;123;151;123 06:32:05 INFO - PROCESS | 6048 | |2;audio-dft;161;161;161;162;162;161;161;159;161;160 06:32:05 INFO - PROCESS | 6048 | |3;audio-fft;75;75;75;124;76;76;74;74;98;74 06:32:05 INFO - PROCESS | 6048 | |4;audio-oscillator;84;85;109;85;85;85;117;85;84;123 06:32:05 INFO - PROCESS | 6048 | |5;imaging-gaussian-blur;116;117;117;116;116;116;116;117;116;116 06:32:05 INFO - PROCESS | 6048 | |6;imaging-darkroom;146;146;146;145;147;145;145;146;146;146 06:32:05 INFO - PROCESS | 6048 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;94;95 06:32:05 INFO - PROCESS | 6048 | |8;json-parse-financial;48;51;49;50;54;49;51;52;50;51 06:32:05 INFO - PROCESS | 6048 | |9;json-stringify-tinderbox;63;63;61;61;61;61;61;61;61;62 06:32:05 INFO - PROCESS | 6048 | |10;stanford-crypto-aes;75;81;79;81;76;78;82;83;107;83 06:32:05 INFO - PROCESS | 6048 | |11;stanford-crypto-ccm;128;123;116;124;118;121;115;124;140;132 06:32:05 INFO - PROCESS | 6048 | |12;stanford-crypto-pbkdf2;160;150;153;153;153;152;152;149;148;156 06:32:05 INFO - PROCESS | 6048 | |13;stanford-crypto-sha256-iterative;60;60;63;63;68;59;60;60;60;60 06:32:05 INFO - PROCESS | 6048 | __end_tp_report 06:32:05 INFO - PROCESS | 6048 | __start_cc_report 06:32:05 INFO - PROCESS | 6048 | _x_x_mozilla_cycle_collect,1582 06:32:05 INFO - PROCESS | 6048 | __end_cc_report 06:32:05 INFO - PROCESS | 6048 | __startTimestamp1468503125187__endTimestamp 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | ------- Summary: start ------- 06:32:05 INFO - PROCESS | 6048 | Number of tests: 14 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:1.87 (1.7%) stddev-sans-first:1.99 06:32:05 INFO - PROCESS | 6048 | Values: 109.0 104.0 109.0 109.0 111.0 109.0 110.0 110.0 109.0 108.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:137.50 stddev:17.21 (12.5%) stddev-sans-first:16.39 06:32:05 INFO - PROCESS | 6048 | Values: 159.0 130.0 126.0 169.0 124.0 124.0 145.0 123.0 151.0 123.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 06:32:05 INFO - PROCESS | 6048 | Values: 161.0 161.0 161.0 162.0 162.0 161.0 161.0 159.0 161.0 160.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:16.43 (21.9%) stddev-sans-first:17.23 06:32:05 INFO - PROCESS | 6048 | Values: 75.0 75.0 75.0 124.0 76.0 76.0 74.0 74.0 98.0 74.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:85.00 stddev:15.63 (18.4%) stddev-sans-first:16.14 06:32:05 INFO - PROCESS | 6048 | Values: 84.0 85.0 109.0 85.0 85.0 85.0 117.0 85.0 84.0 123.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:32:05 INFO - PROCESS | 6048 | Values: 116.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 116.0 116.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:32:05 INFO - PROCESS | 6048 | Values: 146.0 146.0 146.0 145.0 147.0 145.0 145.0 146.0 146.0 146.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:32:05 INFO - PROCESS | 6048 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:1.72 (3.4%) stddev-sans-first:1.56 06:32:05 INFO - PROCESS | 6048 | Values: 48.0 51.0 49.0 50.0 54.0 49.0 51.0 52.0 50.0 51.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:0.85 (1.4%) stddev-sans-first:0.71 06:32:05 INFO - PROCESS | 6048 | Values: 63.0 63.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:81.00 stddev:9.05 (11.2%) stddev-sans-first:9.18 06:32:05 INFO - PROCESS | 6048 | Values: 75.0 81.0 79.0 81.0 76.0 78.0 82.0 83.0 107.0 83.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.00 stddev:7.65 (6.2%) stddev-sans-first:7.98 06:32:05 INFO - PROCESS | 6048 | Values: 128.0 123.0 116.0 124.0 118.0 121.0 115.0 124.0 140.0 132.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:153.00 stddev:3.47 (2.3%) stddev-sans-first:2.44 06:32:05 INFO - PROCESS | 6048 | Values: 160.0 150.0 153.0 153.0 153.0 152.0 152.0 149.0 148.0 156.0 06:32:05 INFO - PROCESS | 6048 | 06:32:05 INFO - PROCESS | 6048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:60.00 stddev:2.71 (4.5%) stddev-sans-first:2.83 06:32:05 INFO - PROCESS | 6048 | Values: 60.0 60.0 63.0 63.0 68.0 59.0 60.0 60.0 60.0 60.0 06:32:05 INFO - PROCESS | 6048 | -------- Summary: end -------- 06:32:05 INFO - PROCESS | 6048 | 06:32:06 INFO - TEST-INFO | 6048: exit 0 06:32:06 INFO - TEST-OK | kraken | took 60485ms 06:32:06 INFO - SUITE-END | took 1173s 06:32:06 INFO - Completed test suite (00:19:33) 06:32:06 INFO - javascript benchmark 06:32:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3318.3197444523867, 3343.9832800835993, 3353.6311005789357, 3363.125587347289, 3388.762786604937, 5311.973440132799, 5455.590830687699, 5503.862403439916, 5505.724713764306, 5507.421720719327, 5407.594430417725, 5469.617126801116, 5479.2602998595175, 5497.697626630534, 5505.311836020497, 4902.632302577304, 4944.678595891264, 4969.8012079516775, 4989.2017277235645, 5036.827505839127, 4858.587020103296, 4869.805207791684, 4876.97561512192, 5008.749562521859, 5045.4702256262935, 4969.105560999037, 4984.551390374865, 4990.550850423461, 4991.600671946236, 4992.026554821811, 4991.32617096691, 5000.7249601271915, 5000.774965126578, 5002.474740152268, 5032.4212715537815, 4844.15227335215, 4869.074875773592, 4881.780319885578, 4896.951030489685, 4930.457649658535, 5355.919661205085, 5383.730813459311, 5386.0, 5397.217403476513, 5401.540869026137, 5830.679312637803, 5849.532037437038, 5855.121731740231, 5859.912101318484, 5863.2670916135485, 5648.802291919763, 5784.2769653793275, 5813.808169325278, 5845.357010728816, 5887.146363777271, 5557.138643510262, 5562.16567514876, 5564.888702225973, 5567.944320556783, 5568.582356323292, 6036.758529658764, 6040.305364883006, 6053.243344581927, 6054.878902421927, 6060.090986352083, 5629.127485239795, 5648.322201335866, 5691.174779656926, 5705.74324155414, 5784.652920824764, 5827.3007239131575, 5862.794802181903, 5870.090136028923, 5883.146943693226, 5883.941160588425, 5786.594938354359, 5788.797392091256, 5799.3040835100055, 5804.738786754606, 5812.912806307909, 5679.914801277984, 5698.686572238566, 5701.828945131652, 5707.971460142756, 5794.449527294901, 4440.33394990754, 4449.7997590108525, 4450.265706158512, 4452.599266066005, 4481.058977614737, 4009.599040095967, 4014.9761810738073, 4024.9798751006056, 4035.4955630546183, 4065.9390109147794, 5560.555155587544, 5602.943970560324, 5614.775408983595, 5639.774409023593, 5675.687837168995, 5919.852003699942, 5937.050071988548, 5965.105234214902, 5966.850828729316, 6014.548908831855, 5473.7263136843, 5556.861078473071, 5577.386487486373, 5664.348599911063, 5681.545476361881, 5089.134847076006, 5090.821821236313, 5091.719955402488, 5094.77073531692, 5110.029094472038, 6138.7237574309265, 6155.045967874987, 6163.476104531075, 6176.969115154486, 6181.690915454209, 5697.888911662186, 5750.30996280449, 5786.189933409242, 5897.380775018647, 5920.171176035445, 6044.24446944132, 6086.786962456293, 6090.086487026982, 6097.847553811191, 6141.6007959482495, 5730.684812335361, 5735.942640573541, 5736.799212027559, 5738.569607279387, 5747.252857128714, 5633.0987042073075, 5808.448197421239, 5811.738471768866, 5817.447342502455, 5855.092460668603, 5694.971525142513, 5738.741756621045, 5786.884262314646, 5788.957987562279, 5792.1311803229855, 5754.9424505754405, 5766.625169363978, 5775.306963164448, 5775.451332123442, 5776.595638305446, 5430.565554755531, 5452.345718513804, 5549.5837812165055, 5573.191887176417, 5678.602497825113, 5746.798862039808, 5757.510611598061, 5778.335491418541, 5782.855428614318, 5786.016377215968, 5625.662460252398, 5625.887482250414, 5627.0, 5629.043062679272, 5644.8024319148635], "value": 5403.660290069185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.6063037764698, 646.218076127885, 655.5083687234574, 659.2583343738295, 662.6752891083371, 32870.17824554387, 44005.0, 44813.0, 44915.55084449155, 44991.0, 47581.0, 47875.28187077196, 48016.0, 48019.519804801945, 48130.27804582934, 8204.138565450632, 8887.64449422024, 9038.18656320931, 9062.093790620951, 10541.84187237192, 10370.0, 10788.190885683605, 10791.892081079206, 10795.08241799448, 10799.352038877652, 10830.079443247334, 10877.292975956578, 10878.945605271963, 10880.12958963281, 10885.782284354347, 8258.339332853357, 8430.494170349737, 10584.31201971877, 10802.783944321109, 10824.891751082467, 10402.0, 10424.94787526065, 10426.113780328682, 10429.634962776267, 10435.269531132824, 43700.0, 43841.34237986433, 43928.56071439277, 43945.560544394786, 44126.779366102965, 3462.342154990544, 3501.0197144799495, 3733.9439908401396, 3738.1776009277914, 4312.892177695583, 33287.16782080467, 35868.10329741751, 36274.8186259067, 37615.24769504622, 37632.0, 4726.865113961888, 4728.40894888139, 4729.905401891943, 4828.8652166740785, 4972.105021096201, 394413.0, 398980.0, 400000.0, 400421.0, 402439.98780006205, 39096.60903390987, 40256.59743402587, 71154.64422677956, 72075.2792472079, 72204.63897680478, 41671.374929376085, 41714.16571668549, 41819.7909010453, 41908.58091419108, 41914.37128443076, 17835.0, 18163.909180454277, 18169.63660726778, 18180.272789088554, 18183.45449636513, 13788.862111378958, 14797.186154761375, 15059.021163624548, 15075.396984120513, 15389.307481163374, 9415.387999779992, 9435.622575097057, 9480.952595237117, 9523.857142142873, 9587.328886977984, 3628.38317486028, 3631.7276204284785, 3654.5797233317976, 3666.138457462494, 3719.776813391205, 994.557421947241, 1010.939343639384, 1053.8103141434615, 1142.3831131189231, 1151.1423989128152, 34439.87343354013, 34799.82600087034, 34842.30315393729, 34881.30237395289, 34963.47554786629, 1034.6585626743156, 1092.1426680056118, 1173.7769823733463, 1230.267990545624, 1234.160770675949, 17410.21654025572, 17893.37373191932, 18038.36865709694, 18089.36687215941, 18147.27410903549, 681714.0, 683451.0, 686288.0, 689085.0, 689742.0, 63018.36981630217, 64135.67932160309, 64373.35626643767, 64581.67709161518, 64592.0, 1298.558490113366, 1394.6095093373872, 1397.5457976157788, 1398.286873694423, 1403.1651167555492, 33755.66244337623, 34716.30567388688, 35295.34981147958, 35341.51400794803, 35698.0, 54585.72707136439, 59743.0, 61256.38743612507, 61305.0, 66061.0, 590026.0, 596891.0, 599368.0, 600222.0, 601182.0, 40875.386869196394, 41876.0, 41895.581044189166, 44503.55496444994, 46450.30324545202, 49069.509304906496, 52526.21210681919, 52696.473035269155, 53020.46979530156, 53406.73296633492, 41002.79498602607, 43043.7847810759, 43730.562694372646, 43972.34041489444, 44349.33475997798, 42350.36474452947, 42917.78541107274, 43049.56950430581, 43432.0, 43838.34242486302, 42304.365434517895, 42925.570744292156, 43381.13237735291, 43877.12245755003, 44203.0, 37667.623323767504, 38107.42838857364, 38403.0, 38518.42222366723, 38864.0, 28713.85643071771, 29130.854345728985, 29177.562336565392, 29396.706032939397, 29519.26201844971], "value": 21066.25956312259, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.3004956112129, 430.04529943525364, 431.8553284649643, 440.4142490487651, 444.04087171709114, 19717.50706232343, 19824.504387390323, 20606.587868242663, 20679.0, 20762.896185519072, 19347.516312092168, 19537.218511259533, 19804.70292945607, 19835.801641983577, 19855.30506432275, 5541.833744987647, 5777.902198582277, 5808.477237048664, 5808.796692115777, 5809.564282678795, 5848.415158484138, 5861.706914654272, 5910.024845900442, 5912.615679980809, 5918.437748413894, 5859.7656093756195, 5862.912056319137, 5863.76544938202, 5866.5306775458075, 5882.6764527950945, 5755.338136114337, 5804.448577385142, 6064.151018857364, 6070.908936365936, 6153.784617538365, 5734.569907256972, 5926.348101708809, 5926.614770039933, 5930.377310382434, 5944.554158438134, 22523.774762252495, 22585.54828903429, 22897.77102228973, 23243.53512929732, 23301.3009609712, 2299.1837897546297, 2461.003293666068, 2480.379905023744, 2614.660094187743, 3068.3556453144865, 10204.846927296096, 10393.428361440117, 10447.42539160346, 10719.464026798629, 10901.781964360669, 1910.8757930734457, 2002.5594369238745, 2039.1129858511595, 2051.2820512820545, 2064.8554601177925, 61893.0, 65307.0, 72962.0, 75376.62311688461, 78849.60575197087, 10417.739556510996, 11485.598004069818, 11508.59719909799, 11710.0, 11762.35307058103, 14986.40054397812, 15195.164265965257, 15770.526884193263, 15800.89393742427, 15866.286017129027, 7040.753573624898, 8340.958295208486, 9040.141186587263, 9192.034836342087, 9265.397749146285, 9111.772205694779, 9133.315001374924, 9150.267978561833, 9261.72214833556, 9263.212626926652, 4736.881577960578, 4941.579965702884, 5090.516400941905, 5141.475163470226, 5168.457311982188, 2102.8317734581196, 2123.872567645946, 2131.504332894055, 2131.9573608527744, 2203.460152262674, 458.2942268905914, 502.8717676992417, 1013.9695809125737, 1024.7088668277875, 1075.8386242063752, 12009.219400738924, 12263.632091037283, 12348.0, 12486.12597118193, 12494.250344979331, 491.3049977577372, 500.0474096845515, 510.0233053702193, 511.0673021735348, 519.2496842063258, 6678.131842860397, 6701.1288532491435, 6720.0255962886085, 6733.494987875929, 6738.494612904052, 452357.0, 467534.0, 484962.6747141039, 490181.0, 493528.0, 99579.50210249047, 99756.0, 100930.0, 101282.0, 101416.49291753494, 513.3429210610425, 522.3261992030239, 522.9346331708537, 523.353658232083, 525.3957948359417, 11368.715782105513, 11474.0, 11515.769684606428, 11601.535938562363, 11721.179517434039, 31299.0, 35725.46411803877, 40967.795161024005, 41558.79220603999, 42414.57585424106, 53921.0, 56662.7166864163, 57018.0, 58190.709046454496, 60613.393866060775, 8117.512949223065, 8314.708985185489, 8456.027556831043, 8532.0, 9026.142516460926, 9833.16418104469, 12884.871151288367, 13096.934515327363, 13125.0, 13921.860781392461, 9065.456072635663, 11174.664760056887, 11722.648320550397, 11860.169788114748, 12163.878361216628, 11675.065994720571, 11924.642260732191, 11974.700632484257, 12478.812817807922, 12609.243445393306, 11605.825912611486, 11642.5342986283, 11668.474918628512, 11774.705632359259, 12002.21985570935, 7759.4568380215105, 7912.4856884302335, 8355.41512094172, 8454.985401751828, 8481.491110533389, 11544.711382215175, 11690.415479226174, 11690.532378704756, 11942.582009629621, 11998.220115692453], "value": 8667.007265614611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.6619211389257, 1578.1241411016888, 1590.340008896308, 1821.2532861526777, 1927.5566619677475, 8451.28164106051, 8820.0, 8851.0, 8991.0, 9003.684871029514, 8784.604692788824, 8937.55312234389, 8945.373823832335, 8954.597043133059, 8961.238294744955, 2126.840486963476, 2402.3513651314133, 2410.590199666061, 2459.1270099114827, 2478.5538603051446, 2434.4644178280837, 2456.238566044523, 2458.0045081741832, 2466.087547607379, 2470.2465747946867, 2424.73327933928, 2440.1093600835657, 2440.9267721968367, 2447.437089469423, 2449.301948944551, 2071.8860462674547, 2357.5992081346126, 2408.229366602688, 2436.8294219404647, 2442.792362649177, 2447.5349683560066, 2474.7030356357172, 2475.207933461293, 2491.576432006545, 2523.2934778262115, 9258.861117083181, 9320.813583728355, 9334.71995840126, 9341.019192984775, 9342.859857102148, 5421.83734487966, 5554.361248456398, 5561.054620714488, 5563.610547261694, 5564.248826408423, 3409.4715319125576, 3439.793612383265, 3503.737219708532, 3594.8741794037346, 3618.1135621772833, 1154.613204576468, 1216.4829947272374, 1225.5526732742485, 2076.6262072826885, 2123.1401282480465, 13275.203487790666, 13489.86510134896, 13520.526781562696, 13539.119957202849, 13542.322883855866, 4795.184818580849, 4916.655834091651, 4959.776810043557, 4979.975100124476, 4991.925121123186, 11345.716357091138, 11358.034567061892, 11399.0, 11405.486753095965, 11414.714632134263, 4960.355153829979, 5682.943170568324, 5685.715714214272, 5686.232358631614, 5693.743781529841, 4958.752062396866, 5124.564412024945, 5134.666246693953, 5152.175651895679, 5160.819371322061, 4317.8272869084885, 4323.524412314643, 4353.085851971122, 4468.262736648417, 4482.843100491467, 1327.4955516903708, 1336.2784096587927, 1344.3009634989946, 1345.3138899161302, 1375.6698392385756, 1059.8887116852773, 1064.0, 1066.0618655583037, 1070.7751372211924, 1071.7106381277013, 6265.530085243625, 6339.2392912850755, 6434.292227854932, 6439.484841212692, 6515.73937042513, 511.34037092151453, 516.318459633288, 1080.5623722392443, 1095.4030053620795, 1108.728361551425, 4311.33174357975, 4331.805068771912, 4348.326009468537, 4389.912201755947, 4401.625861801783, 11580.0, 11927.807219278002, 12016.218945768496, 12017.218880772722, 12040.277583345027, 11200.327980321206, 11712.180147389601, 11746.941265293619, 11911.463984120735, 11984.58053968107, 8730.86903696445, 8794.032656407919, 8845.734627961043, 8859.7342079739, 8868.600912958933, 6405.231372235362, 6609.669516524058, 6680.131582894387, 6687.866242675022, 6728.05807187004, 10106.19150467946, 10464.110550603284, 10940.781184376427, 11091.778164436504, 11114.277571957797, 10391.532381043022, 10732.356058636507, 10752.193585480964, 10754.838677419688, 10854.34873907568, 7509.4367922404945, 8058.435909486279, 8246.216609422096, 8459.365547584079, 8635.179657932485, 8900.955495222483, 8964.058773828914, 8980.326475514232, 8985.730428087169, 8997.235235004837, 7966.721164759438, 8104.8784268237205, 8134.186581341818, 8155.347572194329, 8280.792980175303, 7980.4812687175145, 8146.307563857138, 8151.103378628228, 8274.751757447286, 8300.875486867822, 7143.321384468467, 7339.669714862737, 7375.041244638162, 7380.261973802577, 7415.925840741524, 5447.400785913625, 5465.9614673213555, 5545.223668686306, 5588.245586845724, 5696.458836410535, 5452.781888724565, 5528.281323427928, 5641.746121424628, 5653.123765816305, 5707.600467967369], "value": 4952.908753946583, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.6280379993408, 355.35503061942575, 356.7787971457695, 359.7463788029439, 363.13392558747387, 5237.214417837326, 5367.543758780508, 5431.972840135799, 5449.9835061027425, 5471.91792123118, 5405.810796622119, 5452.6455780374245, 5455.509004189622, 5466.34403871535, 5473.397926228122, 4289.957100429003, 4297.269464191079, 4304.117655880537, 4315.762633055181, 4333.8699839004885, 4039.6162364575466, 4120.814563344657, 4214.6838987075935, 4303.419038429819, 4331.0, 4224.809883555247, 4225.957740422603, 4235.555266696999, 4242.5999420191265, 4248.97875510622, 4209.326507758744, 4236.343366778155, 4244.214820258262, 4259.700791258665, 4295.828166873322, 3712.2389910068373, 3786.7917264550438, 3841.154945911895, 3843.385058390644, 3846.480725102131, 5190.59853839465, 5214.878801057753, 5222.843314700565, 5245.895082098375, 5248.270899132468, 4847.321375007502, 4858.344123543312, 4866.245731911559, 4889.144399730033, 4918.2376731606655, 5509.559235261169, 5613.747381367848, 5619.0, 5646.57650676201, 5648.802291919804, 4144.585541445861, 4152.688548358885, 4154.127633197032, 4176.644985176264, 4188.979055104735, 5745.770169193227, 5799.129430931674, 5802.738876750556, 5895.469407753323, 5903.468687818074, 4199.916001680011, 4287.8499252526635, 4302.892427689333, 4310.4180935573295, 4311.741295522279, 4290.399344091829, 4320.78396080201, 4324.221640104748, 4335.328024156198, 4368.340030788344, 4879.975600122048, 4889.608831293488, 4898.314236006961, 4904.362432883702, 4943.9258411123865, 5549.112142057332, 5652.547796176296, 5660.349059858087, 5692.6299790513485, 5715.228444160069, 1416.482983710938, 1446.5154173351834, 1491.142593009024, 1498.9625259368604, 1500.4598344595936, 967.6613185385199, 977.9168770654574, 989.5992123190119, 995.581855620641, 1006.7785087280787, 4838.346823178897, 4909.87725306863, 4939.185034469272, 4947.975260123676, 4969.254611808257, 5144.845654630367, 5170.242117680007, 5204.739763011834, 5223.145783246969, 5224.791008359623, 4723.338732577442, 4947.1837146871085, 4980.327655766425, 4988.301637770715, 5003.949960500421, 2755.931101722473, 2756.379814541712, 2783.582462630581, 2788.888444462199, 2806.2984253936515, 5339.733013349394, 5379.865503362447, 5396.892062158735, 5399.1091469907815, 5413.675179489243, 5154.0, 5205.73971301441, 5587.413321601173, 5977.252843394575, 5989.35292794485, 6134.877302453926, 6143.846403839851, 6164.0, 6174.8147555573405, 6183.227096612924, 5640.379558248672, 5879.735411906389, 5884.58807883444, 5919.171316015675, 5942.554308426799, 5770.480656740913, 5773.874094551522, 5780.335261444988, 5836.591438599427, 5865.413458654271, 6093.421124993119, 6101.267847858286, 6120.387961203844, 6121.510279177744, 6153.784617538365, 4104.404861295156, 4161.292580261424, 4185.142045880648, 4191.97904010478, 4209.810558524935, 5610.831675049755, 5745.942540574708, 5830.854228644318, 5843.1235314703135, 5866.266716660418, 5609.607327487037, 5611.971940140274, 5627.803026894039, 5659.9151012735665, 5704.318970084054, 5690.971545142248, 5728.369879313189, 5735.827925162252, 5737.454941780524, 5739.62692424991, 5505.339359276913, 5568.303962004749, 5611.971940140274, 5614.242077319673, 5650.886982260414, 5718.542516598745, 5729.1119876419225, 5789.797357092481, 5802.47777700009, 5837.0, 5349.037173308841, 5590.211132437581, 5623.971880140737, 5652.463016013472, 5684.7157642118555], "value": 4299.862195146766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.4921351907739, 779.2674885607529, 783.1502819440906, 851.8168593752343, 900.2887718702226, 16348.100854453016, 16516.339346426128, 17206.483805485823, 17262.223199956, 17282.740758888613, 14838.0, 14991.250437478137, 15004.0, 15007.099574025538, 15025.849741502581, 726.1649103530929, 861.5132450165668, 877.2850127146371, 887.8313120507083, 891.61660485991, 887.1040249348173, 889.9644014239454, 890.1587999340626, 890.5992303463435, 892.995535022324, 932.4591736792644, 932.6968735161066, 934.3833070173687, 934.6541779541545, 935.050923312838, 773.1958762886591, 908.5593487158723, 932.6549176804558, 932.9860052099224, 936.4381371177308, 685.4173952140691, 686.0087174033523, 686.2485578291812, 686.4234043403515, 687.041577000087, 15939.681206375924, 16001.119938403383, 16006.839931600767, 16032.438864639682, 16038.75941860873, 15623.140727259995, 15708.450204242796, 15760.2119894006, 15965.920170399073, 16019.759703604455, 13476.730465390736, 13700.725985480234, 13721.931390342985, 13959.511417100353, 14263.928680356532, 4699.765011749433, 4718.646101542398, 4732.1482133216, 4740.691855029412, 4862.708237505761, 75423.62288188579, 76919.23080769232, 77024.0, 77422.61288693521, 77912.0, 11745.236559623598, 11984.161108722481, 12364.258144511357, 12405.069619778373, 12584.81122783159, 22205.888970555043, 22435.43911402228, 22439.43901402478, 22462.438439039153, 22514.774852251594, 7955.681772729026, 8463.830723385498, 8559.058503564604, 8755.0, 9183.494907780003, 4894.1679914414635, 5014.598832093424, 5180.585553155738, 5229.869253268623, 5384.5692344612335, 3898.434726964574, 4049.8380064797666, 4052.3111071117983, 4052.5339585947404, 4055.371417430303, 671.9160104986877, 673.845015646404, 675.6351570152161, 687.3229868579446, 691.0463560286772, 783.902012248469, 784.5175217241356, 789.4158322841056, 802.8093352698902, 806.3025482957199, 10818.404987725593, 10872.0, 11037.724056898642, 11148.609798657008, 11162.162837787198, 743.687651186503, 800.3877034068942, 824.2746383182881, 830.779843341515, 833.6332013913858, 4956.157453232959, 5074.822381216713, 5163.380394352702, 5286.577073834084, 5411.134218525017, 68744.65627671829, 113583.4320828407, 115519.42240288745, 115900.0, 116432.41783791197, 68301.31698683048, 87377.1262287369, 96302.0, 101189.49405252926, 102318.48840755898, 60096.098558521655, 78179.99999999886, 92575.53712231395, 93978.0, 94012.0, 10712.625058122929, 10870.836937445787, 10976.560937562728, 11157.386343750846, 11205.88794112081, 51677.48322516727, 52076.0, 52424.47575524196, 52510.0, 53201.7339913298, 68477.65761171162, 70059.0, 73447.0, 76853.61573192099, 78801.21198787939, 13662.726745464835, 14003.719925601634, 14293.213873237071, 14572.125672459686, 14952.850471495145, 16240.269187886337, 16302.67394652124, 16338.836611633731, 16667.16664166811, 17019.914900425418, 13444.296471589943, 13585.388657510633, 13814.447422103405, 15795.842041579897, 16043.679126417639, 14926.68824932915, 14963.0, 14985.625359365667, 15287.923560382127, 15770.605734856721, 12448.190867593577, 12789.680257993252, 13149.802752958522, 13363.599092027254, 14198.858011419754, 10842.966335019768, 11009.669709908716, 11231.66305010851, 11319.660410187707, 11416.94291528537, 11899.702507437383, 11997.700057498632, 12200.14598978063, 12276.938615306866, 12477.438515266653], "value": 8071.43325558827, "unit": "score"}], "name": "dromaeo_css", "value": 7440.0453483153415, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 109.0, 109.0, 111.0, 109.0, 110.0, 110.0, 109.0, 108.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 126.0, 169.0, 124.0, 124.0, 145.0, 123.0, 151.0, 123.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 159.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 124.0, 76.0, 76.0, 74.0, 74.0, 98.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 85.0, 85.0, 85.0, 117.0, 85.0, 84.0, 123.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 51.0, 49.0, 50.0, 54.0, 49.0, 51.0, 52.0, 50.0, 51.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 79.0, 81.0, 76.0, 78.0, 82.0, 83.0, 107.0, 83.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 123.0, 116.0, 124.0, 118.0, 121.0, 115.0, 124.0, 140.0, 132.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 150.0, 153.0, 153.0, 153.0, 152.0, 152.0, 149.0, 148.0, 156.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 63.0, 63.0, 68.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 61.3, "unit": "score"}], "name": "kraken", "value": 1472.6999999999998, "alertThreshold": 2.0}]} 06:32:06 INFO - Return code: 0 06:32:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:32:06 ERROR - # TBPL SUCCESS # 06:32:06 INFO - Running post-action listener: _resource_record_post_action 06:32:06 INFO - ##### 06:32:06 INFO - ##### Finished run-tests step (success) 06:32:06 INFO - ##### 06:32:06 INFO - Running post-run listener: _resource_record_post_run 06:32:06 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 286720; Write bytes: 505098240; Read time: 28; Write time: 369644 06:32:06 INFO - TinderboxPrint: CPU usage
13.1% 06:32:06 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 28 06:32:06 INFO - TinderboxPrint: I/O write bytes / time
505,098,240 / 369,644 06:32:06 INFO - TinderboxPrint: CPU idle
8,253.9 (86.9%) 06:32:06 INFO - TinderboxPrint: CPU user
1,198.3 (12.6%) 06:32:06 INFO - TinderboxPrint: Swap in / out
0 / 0 06:32:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252760064; Read time: 0; Write time: 220544 06:32:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 252338176; Read time: 20; Write time: 149100 06:32:07 INFO - Running post-run listener: _upload_blobber_files 06:32:07 INFO - Blob upload gear active. 06:32:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:32:07 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 06:32:07 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:32:07 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:32:07 INFO - (blobuploader) - INFO - Open directory for files ... 06:32:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:32:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:32:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:08 INFO - (blobuploader) - INFO - Done attempting. 06:32:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:32:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:09 INFO - (blobuploader) - INFO - Done attempting. 06:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:32:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:12 INFO - (blobuploader) - INFO - Done attempting. 06:32:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:32:12 INFO - Return code: 0 06:32:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:32:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:32:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849659ef5766c24d4867de3d2e537a9b3b52227a7c5252d7e9748c9c5194840e3dc1185c4b789b1b30be933aab912bfea5e46fb44c5f38a9092e8723184cc28e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/334fa95c0d37dbfef0247c92378bc8a2f9be13122ba41ec93cdf6730ead08f89b62683c4071fb36d3c1f1391d0f60b5476de139a5fdcbd8502a70af59e08308c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2a49c2d36af138c6f49d90427cb236f4972b7a559814d0726a1ec87db7968c3e47ae6a7e621fa66d0f3efaef220d0678a859abdb03e87be4c294e6d3042d7c3"} 06:32:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:32:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:32:12 INFO - Contents: 06:32:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849659ef5766c24d4867de3d2e537a9b3b52227a7c5252d7e9748c9c5194840e3dc1185c4b789b1b30be933aab912bfea5e46fb44c5f38a9092e8723184cc28e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/334fa95c0d37dbfef0247c92378bc8a2f9be13122ba41ec93cdf6730ead08f89b62683c4071fb36d3c1f1391d0f60b5476de139a5fdcbd8502a70af59e08308c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2a49c2d36af138c6f49d90427cb236f4972b7a559814d0726a1ec87db7968c3e47ae6a7e621fa66d0f3efaef220d0678a859abdb03e87be4c294e6d3042d7c3"} 06:32:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:32:12 INFO - Copying logs to upload dir... 06:32:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:32:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.702082 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-14 06:32:12.188633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:32:12.192559) ========= 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=7de08804244eb36560b44971000001c3-1468501898.377813-1277435935 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-Aurora/sha512/849659ef5766c24d4867de3d2e537a9b3b52227a7c5252d7e9748c9c5194840e3dc1185c4b789b1b30be933aab912bfea5e46fb44c5f38a9092e8723184cc28e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/334fa95c0d37dbfef0247c92378bc8a2f9be13122ba41ec93cdf6730ead08f89b62683c4071fb36d3c1f1391d0f60b5476de139a5fdcbd8502a70af59e08308c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2a49c2d36af138c6f49d90427cb236f4972b7a559814d0726a1ec87db7968c3e47ae6a7e621fa66d0f3efaef220d0678a859abdb03e87be4c294e6d3042d7c3"} build_url:https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/Tetp5xqeRIKiksXNOddN5w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849659ef5766c24d4867de3d2e537a9b3b52227a7c5252d7e9748c9c5194840e3dc1185c4b789b1b30be933aab912bfea5e46fb44c5f38a9092e8723184cc28e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/334fa95c0d37dbfef0247c92378bc8a2f9be13122ba41ec93cdf6730ead08f89b62683c4071fb36d3c1f1391d0f60b5476de139a5fdcbd8502a70af59e08308c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2a49c2d36af138c6f49d90427cb236f4972b7a559814d0726a1ec87db7968c3e47ae6a7e621fa66d0f3efaef220d0678a859abdb03e87be4c294e6d3042d7c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:32:12.218160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:32:12.218485) ========= 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=7de08804244eb36560b44971000001c3-1468501898.377813-1277435935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:32:12.303753) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:32:12.304183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:32:12.304507) ========= ========= Total master_lag: 0.18 =========