builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1466501611.57 results: success (0) buildid: 20160620235401 builduid: 8c106f055c244060a072fa85515e387d revision: 8c0aa4aa8701a54f56f2d508002b2b8e2b5a714d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:31.575297) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:31.576115) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:31.576405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:31.625106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:31.625468) ========= 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=6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 02:33:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-06-21 02:33:31 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130219 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:31.793647) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:31.794015) ========= 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=6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.154559 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:31.961220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:31.961613) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8c0aa4aa8701a54f56f2d508002b2b8e2b5a714d --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 8c0aa4aa8701a54f56f2d508002b2b8e2b5a714d --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=6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 02:33:32,062 truncating revision to first 12 chars 2016-06-21 02:33:32,062 Setting DEBUG logging. 2016-06-21 02:33:32,063 attempt 1/10 2016-06-21 02:33:32,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8c0aa4aa8701?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 02:33:32,557 unpacking tar archive at: mozilla-aurora-8c0aa4aa8701/testing/mozharness/ program finished with exit code 0 elapsedTime=0.867052 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:32.845085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:32.845539) ========= script_repo_revision: 8c0aa4aa8701a54f56f2d508002b2b8e2b5a714d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:32.846094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:32.846472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 02:33:32.991217) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-21 02:33:32.991805) ========= /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=6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:33:33 INFO - MultiFileLogger online at 20160621 02:33:33 in /builds/slave/test 02:33:33 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 02:33:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:33:33 INFO - {'append_to_log': False, 02:33:33 INFO - 'base_work_dir': '/builds/slave/test', 02:33:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:33:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:33:33 INFO - 'branch': 'Mozilla-Aurora', 02:33:33 INFO - 'buildbot_json_path': 'buildprops.json', 02:33:33 INFO - 'config_files': ('talos/linux_config.py',), 02:33:33 INFO - 'default_actions': ('clobber', 02:33:33 INFO - 'read-buildbot-config', 02:33:33 INFO - 'download-and-extract', 02:33:33 INFO - 'populate-webroot', 02:33:33 INFO - 'create-virtualenv', 02:33:33 INFO - 'install', 02:33:33 INFO - 'run-tests'), 02:33:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:33:33 INFO - 'download_minidump_stackwalk': True, 02:33:33 INFO - 'download_symbols': 'ondemand', 02:33:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:33:33 INFO - 'tooltool.py': '/tools/tooltool.py', 02:33:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:33:33 INFO - '/tools/misc-python/virtualenv.py')}, 02:33:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:33:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:33:33 INFO - 'installer_path': 'installer.exe', 02:33:33 INFO - 'log_level': 'info', 02:33:33 INFO - 'log_name': 'talos', 02:33:33 INFO - 'log_to_console': True, 02:33:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:33:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:33:33 INFO - 'opt_config_files': (), 02:33:33 INFO - 'pip_index': False, 02:33:33 INFO - 'sps_profile': False, 02:33:33 INFO - 'sps_profile_interval': 0, 02:33:33 INFO - 'suite': 'dromaeojs', 02:33:33 INFO - 'system_bits': '32', 02:33:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:33:33 INFO - 'title': 'talos-linux64-ix-050', 02:33:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:33:33 INFO - 'use_talos_json': True, 02:33:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:33:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:33:33 INFO - 'work_dir': 'build'} 02:33:33 INFO - ##### 02:33:33 INFO - ##### Running clobber step. 02:33:33 INFO - ##### 02:33:33 INFO - Running pre-action listener: _resource_record_pre_action 02:33:33 INFO - Running main action method: clobber 02:33:33 INFO - rmtree: /builds/slave/test/build 02:33:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:33:35 INFO - Running post-action listener: _resource_record_post_action 02:33:35 INFO - ##### 02:33:35 INFO - ##### Finished clobber step (success) 02:33:35 INFO - ##### 02:33:35 INFO - ##### 02:33:35 INFO - ##### Running read-buildbot-config step. 02:33:35 INFO - ##### 02:33:35 INFO - Running pre-action listener: _resource_record_pre_action 02:33:35 INFO - Running main action method: read_buildbot_config 02:33:35 INFO - Using buildbot properties: 02:33:35 INFO - { 02:33:35 INFO - "project": "", 02:33:35 INFO - "product": "firefox", 02:33:35 INFO - "script_repo_revision": "production", 02:33:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:33:35 INFO - "repository": "", 02:33:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:33:35 INFO - "buildid": "20160620235401", 02:33:35 INFO - "pgo_build": "True", 02:33:35 INFO - "basedir": "/builds/slave/test", 02:33:35 INFO - "buildnumber": 305, 02:33:35 INFO - "slavename": "talos-linux64-ix-050", 02:33:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:33:35 INFO - "platform": "ubuntu64_hw", 02:33:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:33:35 INFO - "branch": "mozilla-aurora", 02:33:35 INFO - "repo_path": "releases/mozilla-aurora", 02:33:35 INFO - "revision": "8c0aa4aa8701a54f56f2d508002b2b8e2b5a714d", 02:33:35 INFO - "stage_platform": "linux64-pgo", 02:33:35 INFO - "builduid": "8c106f055c244060a072fa85515e387d", 02:33:35 INFO - "slavebuilddir": "test" 02:33:35 INFO - } 02:33:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 02:33:35 INFO - Running post-action listener: _resource_record_post_action 02:33:35 INFO - ##### 02:33:35 INFO - ##### Finished read-buildbot-config step (success) 02:33:35 INFO - ##### 02:33:35 INFO - ##### 02:33:35 INFO - ##### Running download-and-extract step. 02:33:35 INFO - ##### 02:33:35 INFO - Running pre-action listener: _resource_record_pre_action 02:33:35 INFO - Running main action method: download_and_extract 02:33:35 INFO - mkdir: /builds/slave/test/build/tests 02:33:35 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')]} 02:33:35 INFO - https://queue.taskcluster.net/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:33:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:33:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:33:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/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 02:33:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/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 02:33:37 INFO - Downloaded 1361 bytes. 02:33:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:33:37 INFO - Using the following test package requirements: 02:33:37 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:33:37 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:37 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:33:37 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:37 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:33:37 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:37 INFO - u'jsshell-linux-x86_64.zip'], 02:33:37 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:37 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:33:37 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:33:37 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:37 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:33:37 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:37 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:33:37 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:37 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:33:37 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:37 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:33:37 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:33:37 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')]} 02:33:37 INFO - https://queue.taskcluster.net/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/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 02:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/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 02:33:39 INFO - Downloaded 24472601 bytes. 02:33:39 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'] 02:33:39 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 02:33:41 INFO - Return code: 0 02:33:41 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 02:33: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')]} 02:33:41 INFO - https://queue.taskcluster.net/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:33:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:33:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:33:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/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 02:33:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/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 02:33:48 INFO - Downloaded 24472601 bytes. 02:33:48 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'] 02:33:48 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 02:33:50 INFO - Return code: 0 02:33:50 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')]} 02:33:50 INFO - https://queue.taskcluster.net/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:33:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:33:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:33:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/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 02:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/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 02:33:51 INFO - Downloaded 10833369 bytes. 02:33:51 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'] 02:33:51 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 02:33:51 INFO - Return code: 0 02:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:51 INFO - https://queue.taskcluster.net/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:33:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:33:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:33:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/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 02:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dObwata4TVOS1OcY1SQOlg/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 02:33:53 INFO - Downloaded 63617969 bytes. 02:33:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:33:53 INFO - mkdir: /builds/slave/test/properties 02:33:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:33:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:33:53 INFO - Contents: 02:33:53 INFO - build_url:https://queue.taskcluster.net/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:33:53 INFO - Running post-action listener: _resource_record_post_action 02:33:53 INFO - Running post-action listener: set_extra_try_arguments 02:33:53 INFO - ##### 02:33:53 INFO - ##### Finished download-and-extract step (success) 02:33:53 INFO - ##### 02:33:53 INFO - ##### 02:33:53 INFO - ##### Running populate-webroot step. 02:33:53 INFO - ##### 02:33:53 INFO - Running pre-action listener: _resource_record_pre_action 02:33:53 INFO - Running main action method: populate_webroot 02:33:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:33:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:33:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:33:53 INFO - '--tppagecycles', 02:33:53 INFO - '7'], 02:33:53 INFO - 'tests': ['tsvgm']}}, 02:33:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:33:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:33:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:33:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:33:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:33:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:33:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:53 INFO - 'talos_options': ['--disable-e10s'], 02:33:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:53 INFO - 'talos_options': ['--disable-e10s'], 02:33:53 INFO - 'tests': ['damp', 'tps']}, 02:33:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:53 INFO - 'tests': ['damp', 'tps']}, 02:33:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:33:53 INFO - 'tests': ['dromaeo_dom']}, 02:33:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:33:53 INFO - 'tests': ['a11yr', 02:33:53 INFO - 'ts_paint', 02:33:53 INFO - 'tpaint', 02:33:53 INFO - 'sessionrestore', 02:33:53 INFO - 'sessionrestore_no_auto_restore', 02:33:53 INFO - 'tabpaint']}, 02:33:53 INFO - 'other-e10s': {'tests': ['a11yr', 02:33:53 INFO - 'ts_paint', 02:33:53 INFO - 'tpaint', 02:33:53 INFO - 'sessionrestore', 02:33:53 INFO - 'sessionrestore_no_auto_restore', 02:33:53 INFO - 'tabpaint']}, 02:33:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:33:53 INFO - 'ts_paint', 02:33:53 INFO - 'tpaint', 02:33:53 INFO - 'sessionrestore', 02:33:53 INFO - 'sessionrestore_no_auto_restore', 02:33:53 INFO - 'tabpaint']}, 02:33:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:33:53 INFO - 'ts_paint', 02:33:53 INFO - 'tpaint', 02:33:53 INFO - 'sessionrestore', 02:33:53 INFO - 'sessionrestore_no_auto_restore', 02:33:53 INFO - 'tabpaint']}, 02:33:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:33:53 INFO - 'tests': ['a11yr', 02:33:53 INFO - 'ts_paint', 02:33:53 INFO - 'tpaint', 02:33:53 INFO - 'sessionrestore', 02:33:53 INFO - 'sessionrestore_no_auto_restore', 02:33:53 INFO - 'tabpaint']}, 02:33:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:33:53 INFO - 'tests': ['a11yr', 02:33:53 INFO - 'ts_paint', 02:33:53 INFO - 'tpaint', 02:33:53 INFO - 'sessionrestore', 02:33:53 INFO - 'sessionrestore_no_auto_restore', 02:33:53 INFO - 'tabpaint']}, 02:33:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:33:53 INFO - 'tests': ['tsvgx', 02:33:53 INFO - 'tsvgr_opacity', 02:33:53 INFO - 'tart', 02:33:53 INFO - 'tscrollx', 02:33:53 INFO - 'cart']}, 02:33:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:33:53 INFO - 'tsvgr_opacity', 02:33:53 INFO - 'tart', 02:33:53 INFO - 'tscrollx', 02:33:53 INFO - 'cart']}, 02:33:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:53 INFO - 'talos_options': ['--disable-e10s'], 02:33:53 INFO - 'tests': ['tp5o']}, 02:33:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:53 INFO - 'tests': ['tp5o']}, 02:33:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:53 INFO - 'talos_options': ['--disable-e10s', 02:33:53 INFO - '--xperf_path', 02:33:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:53 INFO - 'tests': ['tp5n']}, 02:33:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:53 INFO - 'talos_options': ['--xperf_path', 02:33:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:53 INFO - 'tests': ['tp5n']}}, 02:33:53 INFO - 'talos.zip': {'path': '', 02:33:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:33:53 INFO - Running post-action listener: _resource_record_post_action 02:33:53 INFO - ##### 02:33:53 INFO - ##### Finished populate-webroot step (success) 02:33:53 INFO - ##### 02:33:53 INFO - ##### 02:33:53 INFO - ##### Running create-virtualenv step. 02:33:53 INFO - ##### 02:33:53 INFO - Running pre-action listener: _resource_record_pre_action 02:33:53 INFO - Running main action method: create_virtualenv 02:33:53 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:53 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 02:33:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:54 INFO - Using real prefix '/usr' 02:33:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:56 INFO - Installing pip.................done. 02:33:56 INFO - Return code: 0 02:33:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbd179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', '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 02:33: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', 'pip>=1.5'] in /builds/slave/test/build 02:33: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 pip>=1.5 02:33:56 INFO - Using env: {'DISPLAY': ':0', 02:33:56 INFO - 'HOME': '/home/cltbld', 02:33:56 INFO - 'LANG': 'en_US.UTF-8', 02:33:56 INFO - 'LANGUAGE': 'en_US:en', 02:33:56 INFO - 'LOGNAME': 'cltbld', 02:33:56 INFO - 'MAIL': '/var/mail/cltbld', 02:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:56 INFO - 'MOZ_NO_REMOTE': '1', 02:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:56 INFO - 'NO_EM_RESTART': '1', 02:33:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:56 INFO - 'PWD': '/builds/slave/test', 02:33:56 INFO - 'SHELL': '/bin/bash', 02:33:56 INFO - 'SHLVL': '1', 02:33:56 INFO - 'TERM': 'linux', 02:33:56 INFO - 'TMOUT': '86400', 02:33:56 INFO - 'USER': 'cltbld', 02:33:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:56 INFO - '_': '/tools/buildbot/bin/python'} 02:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:57 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 02:33:57 INFO - Cleaning up... 02:33:57 INFO - Return code: 0 02:33:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:57 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 0x7febbd179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', '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 02:33:57 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 02:33:57 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 02:33:57 INFO - Using env: {'DISPLAY': ':0', 02:33:57 INFO - 'HOME': '/home/cltbld', 02:33:57 INFO - 'LANG': 'en_US.UTF-8', 02:33:57 INFO - 'LANGUAGE': 'en_US:en', 02:33:57 INFO - 'LOGNAME': 'cltbld', 02:33:57 INFO - 'MAIL': '/var/mail/cltbld', 02:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:57 INFO - 'MOZ_NO_REMOTE': '1', 02:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:57 INFO - 'NO_EM_RESTART': '1', 02:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:57 INFO - 'PWD': '/builds/slave/test', 02:33:57 INFO - 'SHELL': '/bin/bash', 02:33:57 INFO - 'SHLVL': '1', 02:33:57 INFO - 'TERM': 'linux', 02:33:57 INFO - 'TMOUT': '86400', 02:33:57 INFO - 'USER': 'cltbld', 02:33:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:57 INFO - '_': '/tools/buildbot/bin/python'} 02:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:57 INFO - Downloading/unpacking psutil>=3.1.1 02:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:59 INFO - Installing collected packages: psutil 02:33:59 INFO - Running setup.py install for psutil 02:33:59 INFO - building 'psutil._psutil_linux' extension 02:33:59 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 02:34:00 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 02:34:00 INFO - building 'psutil._psutil_posix' extension 02:34:00 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 02:34:01 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 02:34:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:01 INFO - Successfully installed psutil 02:34:01 INFO - Cleaning up... 02:34:01 INFO - Return code: 0 02:34:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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')]} 02:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbd179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', '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 02:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:34: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 mozsystemmonitor==0.3 02:34:01 INFO - Using env: {'DISPLAY': ':0', 02:34:01 INFO - 'HOME': '/home/cltbld', 02:34:01 INFO - 'LANG': 'en_US.UTF-8', 02:34:01 INFO - 'LANGUAGE': 'en_US:en', 02:34:01 INFO - 'LOGNAME': 'cltbld', 02:34:01 INFO - 'MAIL': '/var/mail/cltbld', 02:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:01 INFO - 'MOZ_NO_REMOTE': '1', 02:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:01 INFO - 'NO_EM_RESTART': '1', 02:34:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:01 INFO - 'PWD': '/builds/slave/test', 02:34:01 INFO - 'SHELL': '/bin/bash', 02:34:01 INFO - 'SHLVL': '1', 02:34:01 INFO - 'TERM': 'linux', 02:34:01 INFO - 'TMOUT': '86400', 02:34:01 INFO - 'USER': 'cltbld', 02:34:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:01 INFO - '_': '/tools/buildbot/bin/python'} 02:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:34:03 INFO - Installing collected packages: mozsystemmonitor 02:34:03 INFO - Running setup.py install for mozsystemmonitor 02:34:03 INFO - Successfully installed mozsystemmonitor 02:34:03 INFO - Cleaning up... 02:34:03 INFO - Return code: 0 02:34:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:03 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 0x7febbd179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', '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 02:34:03 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 02:34:03 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 02:34:03 INFO - Using env: {'DISPLAY': ':0', 02:34:03 INFO - 'HOME': '/home/cltbld', 02:34:03 INFO - 'LANG': 'en_US.UTF-8', 02:34:03 INFO - 'LANGUAGE': 'en_US:en', 02:34:03 INFO - 'LOGNAME': 'cltbld', 02:34:03 INFO - 'MAIL': '/var/mail/cltbld', 02:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:03 INFO - 'MOZ_NO_REMOTE': '1', 02:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:03 INFO - 'NO_EM_RESTART': '1', 02:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:03 INFO - 'PWD': '/builds/slave/test', 02:34:03 INFO - 'SHELL': '/bin/bash', 02:34:03 INFO - 'SHLVL': '1', 02:34:03 INFO - 'TERM': 'linux', 02:34:03 INFO - 'TMOUT': '86400', 02:34:03 INFO - 'USER': 'cltbld', 02:34:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:03 INFO - '_': '/tools/buildbot/bin/python'} 02:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:03 INFO - Downloading/unpacking jsonschema==2.5.1 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:34:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:34:06 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 02:34:06 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 02:34:06 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 02:34:06 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 02:34:06 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 02:34:06 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 02:34:06 INFO - Downloading functools32-3.2.3-2.tar.gz 02:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:34:06 INFO - warning: no files found matching '*.txt' 02:34:06 INFO - no previously-included directories found matching 'build' 02:34:06 INFO - no previously-included directories found matching 'dist' 02:34:06 INFO - no previously-included directories found matching '.git*' 02:34:06 INFO - Installing collected packages: jsonschema, functools32 02:34:06 INFO - Running setup.py install for functools32 02:34:07 INFO - warning: no files found matching '*.txt' 02:34:07 INFO - no previously-included directories found matching 'build' 02:34:07 INFO - no previously-included directories found matching 'dist' 02:34:07 INFO - no previously-included directories found matching '.git*' 02:34:07 INFO - Successfully installed jsonschema functools32 02:34:07 INFO - Cleaning up... 02:34:07 INFO - Return code: 0 02:34:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7febbd179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', '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 02:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:34:07 INFO - Using env: {'DISPLAY': ':0', 02:34:07 INFO - 'HOME': '/home/cltbld', 02:34:07 INFO - 'LANG': 'en_US.UTF-8', 02:34:07 INFO - 'LANGUAGE': 'en_US:en', 02:34:07 INFO - 'LOGNAME': 'cltbld', 02:34:07 INFO - 'MAIL': '/var/mail/cltbld', 02:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:07 INFO - 'MOZ_NO_REMOTE': '1', 02:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:07 INFO - 'NO_EM_RESTART': '1', 02:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:07 INFO - 'PWD': '/builds/slave/test', 02:34:07 INFO - 'SHELL': '/bin/bash', 02:34:07 INFO - 'SHLVL': '1', 02:34:07 INFO - 'TERM': 'linux', 02:34:07 INFO - 'TMOUT': '86400', 02:34:07 INFO - 'USER': 'cltbld', 02:34:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:07 INFO - '_': '/tools/buildbot/bin/python'} 02:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:07 INFO - Downloading/unpacking blobuploader==1.2.4 02:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:09 INFO - Downloading blobuploader-1.2.4.tar.gz 02:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:34:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:34:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34:09 INFO - Downloading docopt-0.6.1.tar.gz 02:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:34:09 INFO - Installing collected packages: blobuploader, requests, docopt 02:34:09 INFO - Running setup.py install for blobuploader 02:34:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:34:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:34:10 INFO - Running setup.py install for requests 02:34:10 INFO - Running setup.py install for docopt 02:34:10 INFO - Successfully installed blobuploader requests docopt 02:34:10 INFO - Cleaning up... 02:34:10 INFO - Return code: 0 02:34:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:10 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')]} 02:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:10 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')]} 02:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:10 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 0x7febbd179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', '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 02:34:10 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 02:34:10 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 02:34:10 INFO - Using env: {'DISPLAY': ':0', 02:34:10 INFO - 'HOME': '/home/cltbld', 02:34:10 INFO - 'LANG': 'en_US.UTF-8', 02:34:10 INFO - 'LANGUAGE': 'en_US:en', 02:34:10 INFO - 'LOGNAME': 'cltbld', 02:34:10 INFO - 'MAIL': '/var/mail/cltbld', 02:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:10 INFO - 'MOZ_NO_REMOTE': '1', 02:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:10 INFO - 'NO_EM_RESTART': '1', 02:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:10 INFO - 'PWD': '/builds/slave/test', 02:34:10 INFO - 'SHELL': '/bin/bash', 02:34:10 INFO - 'SHLVL': '1', 02:34:10 INFO - 'TERM': 'linux', 02:34:10 INFO - 'TMOUT': '86400', 02:34:10 INFO - 'USER': 'cltbld', 02:34:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:10 INFO - '_': '/tools/buildbot/bin/python'} 02:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:10 INFO - Running setup.py (path:/tmp/pip-9oPPxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:10 INFO - Running setup.py (path:/tmp/pip-XaMZuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:10 INFO - Running setup.py (path:/tmp/pip-tPAPxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:10 INFO - Running setup.py (path:/tmp/pip-2ajRpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:11 INFO - Running setup.py (path:/tmp/pip-8mT8b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:11 INFO - Running setup.py (path:/tmp/pip-XQxSP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:11 INFO - Running setup.py (path:/tmp/pip-VJ5dXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:11 INFO - Running setup.py (path:/tmp/pip-VnJebB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:11 INFO - Running setup.py (path:/tmp/pip-1MX5z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:11 INFO - Running setup.py (path:/tmp/pip-YamzC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:11 INFO - Running setup.py (path:/tmp/pip-S04ZPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:11 INFO - Running setup.py (path:/tmp/pip-wrcRio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:11 INFO - Running setup.py (path:/tmp/pip-KNRcub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:11 INFO - Running setup.py (path:/tmp/pip-YQx0jF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:11 INFO - Running setup.py (path:/tmp/pip-ALos_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:11 INFO - Running setup.py (path:/tmp/pip-mg6h8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:11 INFO - Running setup.py (path:/tmp/pip-J0ikCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:34:11 INFO - Running setup.py install for manifestparser 02:34:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:34:12 INFO - Running setup.py install for mozcrash 02:34:12 INFO - Running setup.py install for mozdebug 02:34:12 INFO - Running setup.py install for mozdevice 02:34:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:34:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:34:12 INFO - Running setup.py install for mozfile 02:34:12 INFO - Running setup.py install for mozhttpd 02:34:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:34:12 INFO - Running setup.py install for mozinfo 02:34:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:34:12 INFO - Running setup.py install for mozInstall 02:34:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:34:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:34:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:34:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:34:12 INFO - Running setup.py install for mozleak 02:34:12 INFO - Running setup.py install for mozlog 02:34:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:34:13 INFO - Running setup.py install for moznetwork 02:34:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:34:13 INFO - Running setup.py install for mozprocess 02:34:13 INFO - Running setup.py install for mozprofile 02:34:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:34:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:34:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:34:13 INFO - Running setup.py install for mozrunner 02:34:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:34:13 INFO - Running setup.py install for mozscreenshot 02:34:13 INFO - Running setup.py install for moztest 02:34:13 INFO - Running setup.py install for mozversion 02:34:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:34:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:34:13 INFO - Cleaning up... 02:34:13 INFO - Return code: 0 02:34:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:13 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 0x7febbd179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', '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 02:34:13 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 02:34:13 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 02:34:13 INFO - Using env: {'DISPLAY': ':0', 02:34:13 INFO - 'HOME': '/home/cltbld', 02:34:13 INFO - 'LANG': 'en_US.UTF-8', 02:34:13 INFO - 'LANGUAGE': 'en_US:en', 02:34:13 INFO - 'LOGNAME': 'cltbld', 02:34:13 INFO - 'MAIL': '/var/mail/cltbld', 02:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:13 INFO - 'MOZ_NO_REMOTE': '1', 02:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:13 INFO - 'NO_EM_RESTART': '1', 02:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:13 INFO - 'PWD': '/builds/slave/test', 02:34:13 INFO - 'SHELL': '/bin/bash', 02:34:13 INFO - 'SHLVL': '1', 02:34:13 INFO - 'TERM': 'linux', 02:34:13 INFO - 'TMOUT': '86400', 02:34:13 INFO - 'USER': 'cltbld', 02:34:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:13 INFO - '_': '/tools/buildbot/bin/python'} 02:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:13 INFO - Running setup.py (path:/tmp/pip-qyGcf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:14 INFO - Running setup.py (path:/tmp/pip-ZpZX_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:14 INFO - Running setup.py (path:/tmp/pip-GuBzEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:14 INFO - Running setup.py (path:/tmp/pip-Nlm686-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:14 INFO - Running setup.py (path:/tmp/pip-ahoRhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:14 INFO - Running setup.py (path:/tmp/pip-8JyUIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:14 INFO - Running setup.py (path:/tmp/pip-V16lqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:14 INFO - Running setup.py (path:/tmp/pip-1cusRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:14 INFO - Running setup.py (path:/tmp/pip-9kzDcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:14 INFO - Running setup.py (path:/tmp/pip-cqBKN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:14 INFO - Running setup.py (path:/tmp/pip-lYSmam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:14 INFO - Running setup.py (path:/tmp/pip-juCrow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:14 INFO - Running setup.py (path:/tmp/pip-GvNIHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:14 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)) 02:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:14 INFO - Running setup.py (path:/tmp/pip-9A_o3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:15 INFO - Running setup.py (path:/tmp/pip-Y7k0De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:15 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)) 02:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:15 INFO - Running setup.py (path:/tmp/pip-GEQ7x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:15 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)) 02:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:15 INFO - Running setup.py (path:/tmp/pip-owFCXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:15 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)) 02:34:15 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)) 02:34:15 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)) 02:34:15 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)) 02:34:15 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)) 02:34:15 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)) 02:34:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34:17 INFO - Downloading blessings-1.6.tar.gz 02:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:34:17 INFO - Installing collected packages: blessings 02:34:17 INFO - Running setup.py install for blessings 02:34:17 INFO - Successfully installed blessings 02:34:17 INFO - Cleaning up... 02:34:17 INFO - Return code: 0 02:34:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:34:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:17 INFO - Reading from file tmpfile_stdout 02:34:17 INFO - Current package versions: 02:34:17 INFO - argparse == 1.2.1 02:34:17 INFO - blessings == 1.6 02:34:17 INFO - blobuploader == 1.2.4 02:34:17 INFO - docopt == 0.6.1 02:34:17 INFO - functools32 == 3.2.3-2 02:34:17 INFO - jsonschema == 2.5.1 02:34:17 INFO - manifestparser == 1.1 02:34:17 INFO - mozInstall == 1.12 02:34:17 INFO - mozcrash == 0.17 02:34:17 INFO - mozdebug == 0.1 02:34:17 INFO - mozdevice == 0.48 02:34:17 INFO - mozfile == 1.2 02:34:17 INFO - mozhttpd == 0.7 02:34:17 INFO - mozinfo == 0.9 02:34:17 INFO - mozleak == 0.1 02:34:17 INFO - mozlog == 3.2 02:34:17 INFO - moznetwork == 0.27 02:34:17 INFO - mozprocess == 0.22 02:34:17 INFO - mozprofile == 0.28 02:34:17 INFO - mozrunner == 6.11 02:34:17 INFO - mozscreenshot == 0.1 02:34:17 INFO - mozsystemmonitor == 0.3 02:34:17 INFO - moztest == 0.7 02:34:17 INFO - mozversion == 1.4 02:34:17 INFO - psutil == 3.1.1 02:34:17 INFO - requests == 1.2.3 02:34:17 INFO - wsgiref == 0.1.2 02:34:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:17 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 0x7febbd179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', '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 02:34:17 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 02:34:17 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 02:34:17 INFO - Using env: {'DISPLAY': ':0', 02:34:17 INFO - 'HOME': '/home/cltbld', 02:34:17 INFO - 'LANG': 'en_US.UTF-8', 02:34:17 INFO - 'LANGUAGE': 'en_US:en', 02:34:17 INFO - 'LOGNAME': 'cltbld', 02:34:17 INFO - 'MAIL': '/var/mail/cltbld', 02:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:17 INFO - 'MOZ_NO_REMOTE': '1', 02:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:17 INFO - 'NO_EM_RESTART': '1', 02:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:17 INFO - 'PWD': '/builds/slave/test', 02:34:17 INFO - 'SHELL': '/bin/bash', 02:34:17 INFO - 'SHLVL': '1', 02:34:17 INFO - 'TERM': 'linux', 02:34:17 INFO - 'TMOUT': '86400', 02:34:17 INFO - 'USER': 'cltbld', 02:34:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:17 INFO - '_': '/tools/buildbot/bin/python'} 02:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:17 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)) 02:34:17 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)) 02:34:17 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)) 02:34:17 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)) 02:34:17 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)) 02:34:17 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)) 02:34:17 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)) 02:34:17 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)) 02:34:17 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)) 02:34:17 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)) 02:34:17 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)) 02:34:17 INFO - Cleaning up... 02:34:17 INFO - Return code: 0 02:34:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:17 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 0x7febbd179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', '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 02:34:17 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 02:34:17 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 02:34:17 INFO - Using env: {'DISPLAY': ':0', 02:34:17 INFO - 'HOME': '/home/cltbld', 02:34:17 INFO - 'LANG': 'en_US.UTF-8', 02:34:17 INFO - 'LANGUAGE': 'en_US:en', 02:34:17 INFO - 'LOGNAME': 'cltbld', 02:34:17 INFO - 'MAIL': '/var/mail/cltbld', 02:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:17 INFO - 'MOZ_NO_REMOTE': '1', 02:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:17 INFO - 'NO_EM_RESTART': '1', 02:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:17 INFO - 'PWD': '/builds/slave/test', 02:34:17 INFO - 'SHELL': '/bin/bash', 02:34:17 INFO - 'SHLVL': '1', 02:34:17 INFO - 'TERM': 'linux', 02:34:17 INFO - 'TMOUT': '86400', 02:34:17 INFO - 'USER': 'cltbld', 02:34:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:17 INFO - '_': '/tools/buildbot/bin/python'} 02:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:34:18 INFO - Cleaning up... 02:34:18 INFO - Return code: 0 02:34:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:18 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 0x7febbd179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', '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 02:34:18 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 02:34:18 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 02:34:18 INFO - Using env: {'DISPLAY': ':0', 02:34:18 INFO - 'HOME': '/home/cltbld', 02:34:18 INFO - 'LANG': 'en_US.UTF-8', 02:34:18 INFO - 'LANGUAGE': 'en_US:en', 02:34:18 INFO - 'LOGNAME': 'cltbld', 02:34:18 INFO - 'MAIL': '/var/mail/cltbld', 02:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:18 INFO - 'MOZ_NO_REMOTE': '1', 02:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:18 INFO - 'NO_EM_RESTART': '1', 02:34:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:18 INFO - 'PWD': '/builds/slave/test', 02:34:18 INFO - 'SHELL': '/bin/bash', 02:34:18 INFO - 'SHLVL': '1', 02:34:18 INFO - 'TERM': 'linux', 02:34:18 INFO - 'TMOUT': '86400', 02:34:18 INFO - 'USER': 'cltbld', 02:34:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:18 INFO - '_': '/tools/buildbot/bin/python'} 02:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:18 INFO - Downloading/unpacking flake8 02:34:18 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 02:34:18 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 02:34:18 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 02:34:18 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 02:34:18 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 02:34:18 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 02:34:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:34:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:34:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:34:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:34:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:34:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:34:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:34:20 INFO - no previously-included directories found matching 'docs/_build' 02:34:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:34:20 INFO - Running setup.py install for pep8 02:34:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:34:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:34:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:34:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:34:21 INFO - no previously-included directories found matching 'docs/_build' 02:34:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:34:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:34:21 INFO - Cleaning up... 02:34:21 INFO - Return code: 0 02:34:21 INFO - Running post-action listener: _resource_record_post_action 02:34:21 INFO - Running post-action listener: _start_resource_monitoring 02:34:21 INFO - Starting resource monitoring. 02:34:21 INFO - ##### 02:34:21 INFO - ##### Finished create-virtualenv step (success) 02:34:21 INFO - ##### 02:34:21 INFO - ##### 02:34:21 INFO - ##### Running install step. 02:34:21 INFO - ##### 02:34:21 INFO - Running pre-action listener: _resource_record_pre_action 02:34:21 INFO - Running main action method: install 02:34:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:21 INFO - Reading from file tmpfile_stdout 02:34:21 INFO - Detecting whether we're running mozinstall >=1.0... 02:34:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:34:21 INFO - Reading from file tmpfile_stdout 02:34:21 INFO - Output received: 02:34:21 INFO - Usage: mozinstall [options] installer 02:34:21 INFO - Options: 02:34:21 INFO - -h, --help show this help message and exit 02:34:21 INFO - -d DEST, --destination=DEST 02:34:21 INFO - Directory to install application into. [default: 02:34:21 INFO - "/builds/slave/test"] 02:34:21 INFO - --app=APP Application being installed. [default: firefox] 02:34:21 INFO - mkdir: /builds/slave/test/build/application 02:34:21 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'] 02:34:21 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 02:34:37 INFO - Reading from file tmpfile_stdout 02:34:37 INFO - Output received: 02:34:37 INFO - /builds/slave/test/build/application/firefox/firefox 02:34:37 INFO - Running post-action listener: _resource_record_post_action 02:34:37 INFO - ##### 02:34:37 INFO - ##### Finished install step (success) 02:34:37 INFO - ##### 02:34:37 INFO - ##### 02:34:37 INFO - ##### Running run-tests step. 02:34:37 INFO - ##### 02:34:37 INFO - Running pre-action listener: _resource_record_pre_action 02:34:37 INFO - Running main action method: run_tests 02:34:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:37 INFO - Python 2.7.3 02:34:37 INFO - Return code: 0 02:34:37 INFO - grabbing minidump binary from tooltool 02:34:37 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')]} 02:34:37 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 0x24102e0>, '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 0x237c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:37 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 02:34:37 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 02:34:37 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 02:34:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:37 INFO - Return code: 0 02:34:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:34:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:34:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:34:38 INFO - Return code: 0 02:34:38 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/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 02:34:38 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/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 02:34:38 INFO - Using env: {'DISPLAY': ':0', 02:34:38 INFO - 'HOME': '/home/cltbld', 02:34:38 INFO - 'LANG': 'en_US.UTF-8', 02:34:38 INFO - 'LANGUAGE': 'en_US:en', 02:34:38 INFO - 'LOGNAME': 'cltbld', 02:34:38 INFO - 'MAIL': '/var/mail/cltbld', 02:34:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:38 INFO - 'MOZ_NO_REMOTE': '1', 02:34:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:38 INFO - 'NO_EM_RESTART': '1', 02:34:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:38 INFO - 'PWD': '/builds/slave/test', 02:34:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:38 INFO - 'SHELL': '/bin/bash', 02:34:38 INFO - 'SHLVL': '1', 02:34:38 INFO - 'TERM': 'linux', 02:34:38 INFO - 'TMOUT': '86400', 02:34:38 INFO - 'USER': 'cltbld', 02:34:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296', 02:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:38 INFO - '_': '/tools/buildbot/bin/python'} 02:34:38 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/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 02:34:38 INFO - mozversion application_buildid: 20160620235401 02:34:38 INFO - mozversion application_changeset: 8c0aa4aa8701a54f56f2d508002b2b8e2b5a714d 02:34:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:34:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:34:38 INFO - mozversion application_name: Firefox 02:34:38 INFO - mozversion application_remotingname: firefox-dev 02:34:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:38 INFO - mozversion application_vendor: Mozilla 02:34:38 INFO - mozversion application_version: 49.0a2 02:34:38 INFO - mozversion platform_buildid: 20160620235401 02:34:38 INFO - mozversion platform_changeset: 8c0aa4aa8701a54f56f2d508002b2b8e2b5a714d 02:34:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:38 INFO - mozversion platform_version: 49.0a2 02:34:38 INFO - using testdate: 1466501678 02:34:38 INFO - actual date: 1466501678 02:34:38 INFO - starting webserver on 'localhost:36131' 02:34:38 INFO - SUITE-START | Running 2 tests 02:34:38 INFO - TEST-START | dromaeo_css 02:34:38 INFO - operating with platform_type : linux_ 02:34:38 INFO - Initialising browser for dromaeo_css test... 02:34:38 INFO - TEST-INFO | started process 3372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplrp1ga/profile http://localhost:36131/getInfo.html) 02:34:44 INFO - PROCESS | 3372 | __metrics Screen width/height:1600/1200 02:34:44 INFO - PROCESS | 3372 | colorDepth:24 02:34:44 INFO - PROCESS | 3372 | Browser inner width/height: 1024/697 02:34:44 INFO - PROCESS | 3372 | __metrics 02:34:45 ERROR - PROCESS | 3372 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:34:45 INFO - PROCESS | 3372 | console.error: PushService: 02:34:45 INFO - PROCESS | 3372 | stateChangeProcessEnqueue: Error transitioning state 02:34:45 INFO - PROCESS | 3372 | UnknownError 02:34:46 INFO - TEST-INFO | 3372: exit 0 02:34:46 INFO - Browser initialized. 02:34:46 INFO - Running cycle 1/1 for dromaeo_css test... 02:34:46 INFO - TEST-INFO | started process 3468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplrp1ga/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:58 INFO - PROCESS | 3468 | RSS: Main: 145567744 02:34:58 INFO - PROCESS | 3468 | 02:35:49 INFO - PROCESS | 3468 | 1466501749099 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] 02:37:57 INFO - PROCESS | 3468 | Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36131/tests/dromaeo/cssquery-ext.html) 02:37:58 INFO - PROCESS | 3468 | RSS: Main: 252551168 02:37:58 INFO - PROCESS | 3468 | 02:41:01 INFO - PROCESS | 3468 | Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-ext.html (next: http://localhost:36131/tests/dromaeo/cssquery-jquery.html) 02:41:01 INFO - PROCESS | 3468 | RSS: Main: 225910784 02:41:01 INFO - PROCESS | 3468 | 02:44:03 INFO - PROCESS | 3468 | Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36131/tests/dromaeo/cssquery-mootools.html) 02:44:04 INFO - PROCESS | 3468 | RSS: Main: 231469056 02:44:04 INFO - PROCESS | 3468 | 02:47:06 INFO - PROCESS | 3468 | Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36131/tests/dromaeo/cssquery-prototype.html) 02:47:06 INFO - PROCESS | 3468 | RSS: Main: 224935936 02:47:06 INFO - PROCESS | 3468 | 02:50:09 INFO - PROCESS | 3468 | Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36131/tests/dromaeo/cssquery-yui.html) 02:50:10 INFO - PROCESS | 3468 | RSS: Main: 207175680 02:50:10 INFO - PROCESS | 3468 | 02:53:12 INFO - PROCESS | 3468 | Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-yui.html (next: http://localhost:36131/tests/dromaeo/cssquery-dojo.html) 02:53:12 INFO - PROCESS | 3468 | RSS: Main: 257015808 02:53:12 INFO - PROCESS | 3468 | 02:53:12 INFO - PROCESS | 3468 | __start_tp_report 02:53:12 INFO - PROCESS | 3468 | _x_x_mozilla_page_load 02:53:12 INFO - PROCESS | 3468 | _x_x_mozilla_page_load_details 02:53:12 INFO - PROCESS | 3468 | |i|pagename|runs| 02:53:12 INFO - PROCESS | 3468 | |0;dojo.html;3355.1612096975755;3369.292448585797;3382.6109997350304;3399.9320013599745;3423.0928803866977;5536.695481748502;5618.803341883035;5633.21135041094;5640.802571909984;5655.349634792;5602.411746766582;5651.9152212716845;5658.207850900877;5659.207710920464;5661.4621610947;4874.268859671042;4968.801247950078;5081.542661160494;5083.034223497533;5123.052235336456;5015.7492125393765;5029.698218106907;5040.621953353513;5067.695938243699;5147.871303217412;5039.21892106724;5045.318881950926;5072.985402919412;5144.09978253806;5157.5358217760395;5084.694918304914;5122.513361230677;5131.897362052738;5137.999999999981;5168.974155129238;4917.213245880642;4951.306817045581;5009.373828271466;5027.2207807789855;5047.041062198171;5551.528120109796;5569.526590239834;5574.1917421973585;5591.189277554732;5633.32400111985;6016.8194954151;6021.668808215546;6032.396760323976;6060.484858787008;6065.059915713027;5763.1355296705415;5901.4098590141075;5926.585139040269;5956.940430595682;6044.2746870375395;5634.492895639371;5665.943340566583;5668.971655141698;5669.688167150846;5673.517750991171;5965.3139888912465;6155.199824022849;6158.507319414436;6164.938350616526;6168.9691551541955;5720;5783.190353350535;5792.739326730307;5875.823725288248;5896.292444906639;5913.970430147908;5928.199693041471;5939.613925094855;5950.851228719317;5959.374265702126;5786.855328616818;5788.7684492620665;5835.4748072673665;5894.204282421818;5900.675462849498;5850.385709500526;5908.586398952118;5909.940900590939;5917.349091599921;5948.315943666447;4590.862274131715;4600.631949444037;4602.424696912886;4606.124836281096;4620.745858977722;4037.6769858411258;4051.534073581517;4053.108316170438;4122.42286079949;4164.541900390955;5743;5774;5774.740136693859;5780.566457515703;5802.88394232113;5926.081457374114;5964.254468191476;5976.223090998143;5976.850578735566;5993.670348130808;5632.436756324417;5736.1682556029145;5776.595638305278;5782.190493330937;5784.132380143013;5271.736413179402;5277.445868183862;5280.815171469057;5286.9471305287225;5295.735213239323;6380.521460890452;6395.072714456378;6396.168498095218;6398.0402939559435;6400.935990640127;5803.448672376117;5860;5919.4080591940465;5933.614315069507;6032.034874420072;6289.96855015722;6303.149074874833;6324.146240257506;6324.778632747832;6330.177076979963;5913.91129133072;5915.053591425351;5918.260217472816;5919.348871624032;5959.553033522589;5750.5112065474905;5904.114382842608;5907.675077870586;5982.7307771149535;6042.3655516170165;5887.116932460165;5893.616914900518;5896.14505896634;5898.705064746831;5900.616459930091;5745.798897038583;5867.119932010062;5876.08920617305;5876.735546900314;5877.23595932526;5623.971880140573;5626.043572592587;5651.604387692986;5704.2014118024335;5724.513416359489;5872.970635146797;5944.791932282349;5946.583739138218;5949.018411962151;5958;5581.972090139523;5670.914936275876;5782.653040817564;5786.652800831964;5792.652440853562 02:53:12 INFO - PROCESS | 3468 | |1;ext.html;605.9000264956283;648.4002297874466;657.2802780954855;669.307266978677;671.7010930136091;32445.351092978126;35103.47344789827;45339.31991020129;46268.07463850721;46341.30488042674;47288.290675639895;47688.52311476884;47865;47865.52134478654;47873.7606311968;9085.227755640763;9290.860637090449;9292.488913109777;9296.8605470918;9300.674476393327;8408.915910840906;10771.24601277911;11033.393163376011;11052;11387.715307117305;11175.161862860277;11255.324680519154;11257.380844053574;11263.098952083814;11263.380514071723;8488.618012189467;10812.405317707522;11046.668599942015;11126.054285385711;11129.888701112966;10961.61634342802;11043.337399756041;11052.281601695864;11059;11061.225714200009;41575;41914;41964.160716785496;41996;41998.79000605008;3731.104534911629;3769.6418840210135;3791.563970143414;3896.7272290939645;3922.3332033554366;32795;33126.33747325064;33452.49821252683;33487.6651233487;33620.49569256463;4482.153189281913;4550.089982003579;4588.587027167571;4623.8150473981;4633.235516139866;349272;349837;350060;350854.99999999744;351522;59244;59875;59925.40074599198;60056.39943600595;60126.699366502886;37921.431178532344;38494.230115397535;38511;40624;40709.79645101756;16649;16693.499195024167;16734.916325418297;16738.581535461468;16761.83238167627;11749.353785541707;12035.699107522381;12134.15060945743;12566.308853013172;12646.936765316115;20376.694349584766;20567.8971605141;20581.353491720627;20595.794042059686;20602.072906719233;7269.563826170341;7303.780886573411;7305.488615796843;7538.434617403716;7627.771166865003;1062.3838173859144;1180.9114316426303;1185.1763024697752;1198.7782260281876;1230.7692307692307;33338.499922501185;33849.66150338514;33893.66106338905;33986;34379.312413752086;1107.4850194659523;1158.8339917994795;1160.5647882044234;1220.1093201962617;1259.9559015434415;16627.251773670214;16702.331906723593;16877.36757784617;16955.406560770312;17252.309907603805;595563;597830;600392;600891;602233;57435;57837.13244301339;58001.70999145062;58016;58126.4187358121;1367.5145323410047;1459.0807791091545;1490.4708828365774;1493.1862135136378;1501.5045035138378;31881.68118318787;33372.58584623969;33396;34007.659923400446;34774.13064673403;50715;51428;51428.22857657063;51444;51531.74234128955;453800;456405;456964;457808;459880;25195.622065668664;29019.27451813637;29122.417551649272;30738.692613073585;30884.22789430282;48687.26969095537;49222.75388623034;49858.25212621741;49900;50600;40750.59249407586;41256.58743412527;41393.79303103465;42632.78683606562;43494.56505434905;40792.184156316114;41566.37650435185;41859.7907010463;42266.36600450934;42349;41128.38307425451;41223.381649275885;44138;44218.77890610526;44327.778361109275;36661.266774663825;38727;39413.60586394214;39630.2073958525;40230.59769402268;29228.853855730584;29299.7070029297;29632;29972.70027299699;30000 02:53:12 INFO - PROCESS | 3468 | |2;jquery.html;416.4773209621924;419.1930533722584;420.80222295521094;427.1030835245984;437.31560108430307;18902.716459253104;19754.506137346554;20309.086091125897;21037.894810525926;21639.56720865582;17263.223154958025;18834.434966951012;19938.102785374693;20601.690974635392;20655.483612909684;5724.68514231716;5927.703614819264;5959.493443057346;5960.0761881908375;5966.164736936832;4229.323308270677;4365.738055716667;5808.1287806829105;5920.52635789138;6328.715207815636;6597.076409302702;6684.565503242274;6699.832504187386;6710.29541898101;6719.2272888617945;6535.509836762238;6549.541532092755;6593.20881494219;6607.93392066078;6649.9667501662425;3965.8017099144927;4153.792310384499;4155.293600087962;5891.705414729289;5900.911486327708;21842.907854607365;22521.549569008526;22747.886260568757;23856.880715596486;24064.398390040387;2434.914777982762;2647.1926062550915;2717.7961652876115;2996.8951086712077;3021.7884748067645;14317.856821431757;15076.924615376962;15164.696706065928;15289.311980960883;15377.154256515887;2028.239410221167;2029.2288930206428;2119.851610387258;2133;2155.698202251686;60286.397136028514;63405.36594634041;69612.30387696109;72575.63712181458;84796.57601711951;11058.170637202242;11255.718607034889;11298.435078246219;11390.601328953448;11395.94302028501;15832.208389580475;15922.203889805463;15940.681186376207;15954.441594544136;15978.360865565479;8473.95763021181;8524;8558.95720521406;8620.396572239883;8771.912280877237;8081.393895457864;8163.346932245406;8316;8471.745847624581;8485.830283394298;6778.356056174655;7034.964825175944;7057.788266352018;7072.575645461289;7122.679479423438;1928.431112821721;1950.9414717558495;1971.6056788642043;2035.765886922993;2056;466.56842420761336;871.8169184471332;1012.3622118065572;1059.21618002679;1061.0185578340004;11370.545178192946;11876.76246475083;12100.515979360904;12590.937045314715;12640.494380224687;458.3331253026838;477.72530794793136;494.8540180646718;496.7913476339946;503.70029832249753;6631.86736265272;6714.630695311707;6734.023566582916;6758.594484330956;6775.017622444817;565734;591676;592509;596835;598302;64419.677901610194;91920;104433;105282;107140.46429767802;479.1566842357406;484.26150121064956;486.5329283887437;487.59529590439143;490.60016086889783;11185.776284474428;11358.26171298863;11375.829362559734;11395.145364097893;11413.60052398162;39555.2088958225;40655.59344406518;41011.38482922699;42083.7895810519;42210.36684449797;59399.40600593939;60442.39557604368;62341.688291558254;62763.37236627758;63434;7900.486468379537;8293.668253269801;8324.958375208327;8958.82082358336;9273.582688778886;10330;13611.931940340235;13951.720965580835;13971.650708732363;14090.78863817023;11886.940565297118;12148.271103733805;12158.635240942785;12170.817437738264;12559.93720031394;11905.345206013752;11950.880491195325;11990.100742444178;12074.75850483003;12330.568430104904;12339.07456940751;12361.62915112548;12530.874691253335;12596.622101336974;12598.433070511666;7928.326092282221;7996.880046799419;8015.639296231567;8063.55650439208;8117.959410202911;11219.382933938712;12228.87771122313;12240.571579994657;12468.127231094099;12563.057770667054 02:53:12 INFO - PROCESS | 3468 | |3;mootools.html;1415.9504417345395;1582.525242427272;1592.482443205958;1788.30256200082;1927.1809480970592;9219.446833190013;9487.952560237198;9531.237500999929;9782.755431114225;9783.364081334708;9559.952200239006;9749.268804839649;9763.804723905518;9766.560504777284;9768.218542516599;2178.302943058222;2330.33585428153;2392.8803559822027;2476.8266221364465;2510.63595778612;2505.24842547236;2515.7987361011074;2518.9748102518924;2519.370157460635;2520.2565243253193;2421.9152329668464;2454.3864033991504;2468.7778099971;2472.7527247275307;2479.7396273391305;2116.7777383374755;2182.4216582605623;2185.508260641359;2358.50471401006;2387.1048356866177;2363.645453182019;2396.928092157221;2398.100712232913;2402.3994001499627;2406.759324067597;9636.132748052709;9708.708738737849;9730.951345243298;9736.805263894754;9740.561674724584;5561.360443549003;5664.235328230678;5673.943260567424;5687.431256874321;5691.117876729114;3533.1343820764077;3623.4564815277918;3628.219932714479;3828.157805282833;3844.308024555579;1103.7516558774212;1111.1888321525332;1124.0497736427292;1146.3752255021034;1158.507634255438;13915.443382264697;13925.23411212383;13953.930230348884;13993.510227142104;14031.508897188549;4959.479254678279;5027.195648696191;5036.647434679538;5055.292259083732;5150.4334523202415;11623.244489108181;11625.069994400428;11665.88334116665;11667.533298667959;11682.357470339213;5844.415558444207;5874.412558744091;5884.588078834526;5886.6173698709445;5891.086881533369;4820.638452116105;5256.737163141827;5363.892722145613;5379.112446446371;5424.240606315119;4257.70196086271;4273.059926816096;4354.063876266618;4376.365427013129;4382.956170438255;1291.0768800307826;1298.0653929170983;1302.6808431934048;1323.2391374959436;1326.383231797219;914.4970266353612;917.7246825952187;958.8034452937131;967.666155176463;971.3589031239349;6224.221972253468;6521.315261897433;6528.314526974599;6575.079488871562;6617;433.02137169996035;433.7722695584843;437.5427678076418;467.47642640243146;471.32129733184104;4258.893527661833;4319;4340.327249276367;4389.4513185851765;4421.071574969228;11316;11485;11565.190436669352;11642.126840486997;11726.472308746126;11466.770664586662;11467.885321146849;11488.195826292247;11571.42142892852;11577.479013444416;8706.47761134334;9027.14242146995;9034.096590341045;9210.585523651453;9233.861492077624;6419.935800641933;6858.211305699909;6867.828304292432;6927;6938.5143039986715;11185.66443006711;11472;11528;11626.70933226676;11708.297502149557;11391.430428478709;11684.591039313584;11730.824037639271;11793.764124717629;11794.29234245948;7921.524708517507;8447.535385553854;8510.723391491325;8590.226879580869;8636.093210212837;9779.755506112404;9855;9890.752731181778;9938.602455901972;9941.900580994386;8652.307815374881;8933.15135062168;8940.329475289249;8976.192142707188;9034.638614455349;8576.828463430822;8606.483610983361;8673.869891951499;8722.25860801839;8885.644574217218;7792.61036948139;7827.060752709711;7864.5281283123195;7873.409494287836;7883.369330453665;5329.520343169133;5482.369527504388;5549.889002219852;5585.1901474286815;5628.971855140862;5386.299781028441;5454.945450545444;5505.752241149078;5689.630174038674;5855.03391940325 02:53:12 INFO - PROCESS | 3468 | |4;prototype.html;328.0682860675682;337.75006495193566;343.229449885008;348.9075395020319;352.6262162108165;5402.243685883975;5403.8108666196695;5418.864528386793;5432.13085906255;5469.753861076251;5349.144136938091;5366.91949620756;5369.40936496985;5401.002443643776;5425.511703946644;4037.9394309085387;4221.804661575979;4229.646513115797;4235.470566179228;4254.127903779718;4050.6151915567975;4232.703710740249;4239.682023848209;4254.085661452344;4257.850975215868;4202.852900148496;4212.578742125794;4215.3255479123345;4215.641670458;4216.304309788881;4040.2525532776235;4097.569755175723;4196.538380778112;4200.558941311149;4243.448351714288;3518.7888726676483;3740.7007439404783;3747.0819649186124;3768.1144930941205;3774.8298027611527;5201.28357641981;5201.8959620807755;5213.165893457029;5218.538809133449;5220.060389129955;4704.200285951397;4826.589739872115;4850.4236123259725;4864.173090574611;4869.318295438641;5569.554435645138;5613.831585052455;5614.3543492498475;5632.718364081779;5643.407442218549;4167.291560434734;4180.310248808943;4186.6859985500905;4194.559571245006;4198.412222288882;5591.916121258185;5824.854378640525;5942.465178133945;5947.1376650385455;5951.791687290924;4132.152908653718;4139.81370838313;4141.440905477722;4161.521425036099;4170.457840480718;4167.458230430025;4182.749035057906;4187.267228235047;4188.204241194163;4204.159168166379;4651.837185698484;4736.881577960509;4743.359646447754;4785.760711964388;4820.975895120572;5612.691301978349;5649.728811017489;5663.688497132614;5670.829875103754;5672;1422.5945605502382;1439.2443966917451;1440.1071335771678;1457.6210185351886;1460.1677044084981;901.7925877048316;913.6847787513298;918.169057003413;918.205752024494;931.6226928094133;5027.421846487628;5386.703731294738;5507.752151153128;5642.463965923231;5646.317998950548;5810.912836307459;5824.708764561839;5836.066229403275;5857;5861.6189947653265;5349.037173308764;5583.939051580187;5623.184638227516;5656.660600363992;5678.205051292823;3055.297281625194;3068.5397190421168;3109.5335699645234;3110.9533356999664;3117.973317343745;6113.908291375633;6126.356732543019;6136.754529818846;6149.96925015372;6171.65477118692;5636.718164091861;5932.614380065282;5992.221011268507;6010.639361638228;6030.33666296707;6152.569320147636;6185.659788711574;6191.783287584913;6197.566170368031;6214.720337584729;5607.80372686954;5832.533397328119;5889.734961926638;5893.292804863444;5899.410058994066;5819.243498345188;5830.47525722687;5855.306558982916;5855.619384739978;5865.501432378295;6179.505639548735;6214.751409943552;6226.564140510302;6260.373962603703;6274.560780745486;4048.4939382577177;4235.618794308527;4251.086016506466;4257.361395790656;4266.786660666892;5754.56840736938;5769.163471296554;5775.6823374714795;5814.273215848019;5824.893270278633;5439.374471935778;5667.744951477111;5682.516986056066;5700.771969121189;5703.230063941481;5620.747066382104;5675.347335056521;5692.914606280992;5715.485606295453;5718.456746609066;5482.28730265079;5501.889962200814;5508.44915508446;5541.224228608079;5554.555815487922;5472.945270547243;5514.36584792754;5712.80031193454;5736.799212027559;5753.913691294718;5581.74882130297;5637.5489960802215;5637.887242255214;5643.830685079454;5644.350899646429 02:53:12 INFO - PROCESS | 3468 | |5;yui.html;728.7158008376731;781.9218078192185;785.9331956783673;799.9760007199784;805.3516918880299;14748;14846.925765371185;14866.405343786235;14874.479393221212;15093.094414335133;14017.649558761035;14111.576652700409;14129;14135.929320353409;14138.08102473341;723.1430754555868;843.2368706320759;865.7186414415308;871.0505548951658;871.9302455803552;861.9525926074064;862.8015556422026;863.0118514301122;867.2801574693021;871.1593312453481;909.8271328447573;918.9862152067724;919.0533750237266;919.1130559010553;919.5034681272139;754.7320701151094;894.0612357025097;904.8461761500561;919.342669990953;922.5202894494893;685.5715178013742;685.7051467868814;685.7736946807541;685.8456847209388;685.9142607174103;14056.508022219276;14103.435862565486;14140.080894741912;14140.92929535356;14153.504627337994;14773.482928097465;14872.182029988346;15116.54650360491;15124.773128402972;15208.315625796755;13023.28371939543;13123.86876131236;13142.934285328607;13215.867841321657;13372.095907604824;4640.211164102111;4655.2784318430695;4670.556297151765;4730.574248317634;4793.640476964207;74078.62960685216;77319;78122.21877781206;78660.21339786587;79158.20841791623;12305.93847030777;12306.876931230752;12365.690857728629;12455.813162802566;12460.626181214579;22377.776222237568;23452.882735586212;23576.0569577215;23589.0564377423;23693.17073902405;8758.824823503493;8765.430247033923;9085.591148398205;9186;9247.861282080774;4709.552592503706;5153.17549192135;5165.483451654804;5168.53483186515;5196.064708352457;3985.362342025262;4087.9386809197886;4089.97955010229;4102.774347410861;4104.856330028435;628.4375483941938;681.0431343961742;694.8019814352886;703.1421665567999;726.989095163573;561.7472137538124;627.4603840696997;670.6948338505968;778.6496076765478;786.0645831460544;10023.348482348623;10373.377597344033;10490.108340790966;10543.894561054445;10558;682.9180498340131;696.2828286864537;716.9032180655545;727.0875051809944;811.4279432999721;4465.218586747306;4744.786484608201;4805.183118869801;4822.324874517571;4905.117078925757;100632;112660.43669781598;116080;119982.40008800075;120053;66293.33706662872;101156;102487;104303;104738;90648;94069.5296523513;94623.52688236652;94707;94831.52584236897;9205.677801277192;9415.576299066695;9495.382800118246;9522.714318570454;9549.427034377959;51234.74382628063;51376.743116285674;51647.741761290956;51987.74006130097;52379.476205238985;75216.62391688007;78507;79219;80241.59879200567;80939.19060809317;12354.814677780021;12449.564265250672;12544.74910501803;12681.619551413472;12983.221006739626;12744;13284;13451;13589.320533973065;14097.647558811112;12010.219335743148;12041.09691773103;12326.260424374566;12385;12429.192102513307;12447.128700990843;12614.432350544064;12729.236245825281;12738.554150604685;12746.298953557643;11089.88910110921;11508.194426390073;11711.355875426932;11725.472353744273;11753.529858805894;10177.643782467874;10311.793764124526;10448.634297799541;10487.737806554896;10502.317349372266;10047.397156170653;10064.899351006396;10120.949395252977;10166.542505587118;10418.374897506174 02:53:12 INFO - PROCESS | 3468 | __end_tp_report 02:53:12 INFO - PROCESS | 3468 | __start_cc_report 02:53:12 INFO - PROCESS | 3468 | _x_x_mozilla_cycle_collect,890 02:53:12 INFO - PROCESS | 3468 | __end_cc_report 02:53:12 INFO - PROCESS | 3468 | __startTimestamp1466502792686__endTimestamp 02:53:12 INFO - PROCESS | 3468 | 02:53:12 INFO - PROCESS | 3468 | ------- Summary: start ------- 02:53:12 INFO - PROCESS | 3468 | Number of tests: 6 02:53:12 INFO - PROCESS | 3468 | 02:53:12 INFO - PROCESS | 3468 | [#0] dojo.html Cycles:165 Average:5568.48 Median:5780.57 stddev:619.80 (10.7%) stddev-sans-first:596.89 02:53:12 INFO - PROCESS | 3468 | Values: 3355.2 3369.3 3382.6 3399.9 3423.1 5536.7 5618.8 5633.2 5640.8 5655.3 5602.4 5651.9 5658.2 5659.2 5661.5 4874.3 4968.8 5081.5 5083.0 5123.1 5015.7 5029.7 5040.6 5067.7 5147.9 5039.2 5045.3 5073.0 5144.1 5157.5 5084.7 5122.5 5131.9 5138.0 5169.0 4917.2 4951.3 5009.4 5027.2 5047.0 5551.5 5569.5 5574.2 5591.2 5633.3 6016.8 6021.7 6032.4 6060.5 6065.1 5763.1 5901.4 5926.6 5956.9 6044.3 5634.5 5665.9 5669.0 5669.7 5673.5 5965.3 6155.2 6158.5 6164.9 6169.0 5720.0 5783.2 5792.7 5875.8 5896.3 5914.0 5928.2 5939.6 5950.9 5959.4 5786.9 5788.8 5835.5 5894.2 5900.7 5850.4 5908.6 5909.9 5917.3 5948.3 4590.9 4600.6 4602.4 4606.1 4620.7 4037.7 4051.5 4053.1 4122.4 4164.5 5743.0 5774.0 5774.7 5780.6 5802.9 5926.1 5964.3 5976.2 5976.9 5993.7 5632.4 5736.2 5776.6 5782.2 5784.1 5271.7 5277.4 5280.8 5286.9 5295.7 6380.5 6395.1 6396.2 6398.0 6400.9 5803.4 5860.0 5919.4 5933.6 6032.0 6290.0 6303.1 6324.1 6324.8 6330.2 5913.9 5915.1 5918.3 5919.3 5959.6 5750.5 5904.1 5907.7 5982.7 6042.4 5887.1 5893.6 5896.1 5898.7 5900.6 5745.8 5867.1 5876.1 5876.7 5877.2 5624.0 5626.0 5651.6 5704.2 5724.5 5873.0 5944.8 5946.6 5949.0 5958.0 5582.0 5670.9 5782.7 5786.7 5792.7 02:53:12 INFO - PROCESS | 3468 | 02:53:12 INFO - PROCESS | 3468 | [#1] ext.html Cycles:180 Average:62762.23 Median:38502.62 stddev:127513.14 (331.2%) stddev-sans-first:127785.45 02:53:12 INFO - PROCESS | 3468 | Values: 605.9 648.4 657.3 669.3 671.7 32445.4 35103.5 45339.3 46268.1 46341.3 47288.3 47688.5 47865.0 47865.5 47873.8 9085.2 9290.9 9292.5 9296.9 9300.7 8408.9 10771.2 11033.4 11052.0 11387.7 11175.2 11255.3 11257.4 11263.1 11263.4 8488.6 10812.4 11046.7 11126.1 11129.9 10961.6 11043.3 11052.3 11059.0 11061.2 41575.0 41914.0 41964.2 41996.0 41998.8 3731.1 3769.6 3791.6 3896.7 3922.3 32795.0 33126.3 33452.5 33487.7 33620.5 4482.2 4550.1 4588.6 4623.8 4633.2 349272.0 349837.0 350060.0 350855.0 351522.0 59244.0 59875.0 59925.4 60056.4 60126.7 37921.4 38494.2 38511.0 40624.0 40709.8 16649.0 16693.5 16734.9 16738.6 16761.8 11749.4 12035.7 12134.2 12566.3 12646.9 20376.7 20567.9 20581.4 20595.8 20602.1 7269.6 7303.8 7305.5 7538.4 7627.8 1062.4 1180.9 1185.2 1198.8 1230.8 33338.5 33849.7 33893.7 33986.0 34379.3 1107.5 1158.8 1160.6 1220.1 1260.0 16627.3 16702.3 16877.4 16955.4 17252.3 595563.0 597830.0 600392.0 600891.0 602233.0 57435.0 57837.1 58001.7 58016.0 58126.4 1367.5 1459.1 1490.5 1493.2 1501.5 31881.7 33372.6 33396.0 34007.7 34774.1 50715.0 51428.0 51428.2 51444.0 51531.7 453800.0 456405.0 456964.0 457808.0 459880.0 25195.6 29019.3 29122.4 30738.7 30884.2 48687.3 49222.8 49858.3 49900.0 50600.0 40750.6 41256.6 41393.8 42632.8 43494.6 40792.2 41566.4 41859.8 42266.4 42349.0 41128.4 41223.4 44138.0 44218.8 44327.8 36661.3 38727.0 39413.6 39630.2 40230.6 29228.9 29299.7 29632.0 29972.7 30000.0 02:53:12 INFO - PROCESS | 3468 | 02:53:12 INFO - PROCESS | 3468 | [#2] jquery.html Cycles:180 Average:31466.34 Median:4154.54 stddev:96688.59 (2327.3%) stddev-sans-first:96931.72 02:53:12 INFO - PROCESS | 3468 | Values: 416.5 419.2 420.8 427.1 437.3 18902.7 19754.5 20309.1 21037.9 21639.6 17263.2 18834.4 19938.1 20601.7 20655.5 5724.7 5927.7 5959.5 5960.1 5966.2 4229.3 4365.7 5808.1 5920.5 6328.7 6597.1 6684.6 6699.8 6710.3 6719.2 6535.5 6549.5 6593.2 6607.9 6650.0 3965.8 4153.8 4155.3 5891.7 5900.9 21842.9 22521.5 22747.9 23856.9 24064.4 2434.9 2647.2 2717.8 2996.9 3021.8 14317.9 15076.9 15164.7 15289.3 15377.2 2028.2 2029.2 2119.9 2133.0 2155.7 60286.4 63405.4 69612.3 72575.6 84796.6 11058.2 11255.7 11298.4 11390.6 11395.9 15832.2 15922.2 15940.7 15954.4 15978.4 8474.0 8524.0 8559.0 8620.4 8771.9 8081.4 8163.3 8316.0 8471.7 8485.8 6778.4 7035.0 7057.8 7072.6 7122.7 1928.4 1950.9 1971.6 2035.8 2056.0 466.6 871.8 1012.4 1059.2 1061.0 11370.5 11876.8 12100.5 12590.9 12640.5 458.3 477.7 494.9 496.8 503.7 6631.9 6714.6 6734.0 6758.6 6775.0 565734.0 591676.0 592509.0 596835.0 598302.0 64419.7 91920.0 104433.0 105282.0 107140.5 479.2 484.3 486.5 487.6 490.6 11185.8 11358.3 11375.8 11395.1 11413.6 39555.2 40655.6 41011.4 42083.8 42210.4 59399.4 60442.4 62341.7 62763.4 63434.0 7900.5 8293.7 8325.0 8958.8 9273.6 10330.0 13611.9 13951.7 13971.7 14090.8 11886.9 12148.3 12158.6 12170.8 12559.9 11905.3 11950.9 11990.1 12074.8 12330.6 12339.1 12361.6 12530.9 12596.6 12598.4 7928.3 7996.9 8015.6 8063.6 8118.0 11219.4 12228.9 12240.6 12468.1 12563.1 02:53:12 INFO - PROCESS | 3468 | 02:53:12 INFO - PROCESS | 3468 | [#3] mootools.html Cycles:180 Average:6380.98 Median:4890.06 stddev:3750.47 (76.7%) stddev-sans-first:3742.43 02:53:12 INFO - PROCESS | 3468 | Values: 1416.0 1582.5 1592.5 1788.3 1927.2 9219.4 9488.0 9531.2 9782.8 9783.4 9560.0 9749.3 9763.8 9766.6 9768.2 2178.3 2330.3 2392.9 2476.8 2510.6 2505.2 2515.8 2519.0 2519.4 2520.3 2421.9 2454.4 2468.8 2472.8 2479.7 2116.8 2182.4 2185.5 2358.5 2387.1 2363.6 2396.9 2398.1 2402.4 2406.8 9636.1 9708.7 9731.0 9736.8 9740.6 5561.4 5664.2 5673.9 5687.4 5691.1 3533.1 3623.5 3628.2 3828.2 3844.3 1103.8 1111.2 1124.0 1146.4 1158.5 13915.4 13925.2 13953.9 13993.5 14031.5 4959.5 5027.2 5036.6 5055.3 5150.4 11623.2 11625.1 11665.9 11667.5 11682.4 5844.4 5874.4 5884.6 5886.6 5891.1 4820.6 5256.7 5363.9 5379.1 5424.2 4257.7 4273.1 4354.1 4376.4 4383.0 1291.1 1298.1 1302.7 1323.2 1326.4 914.5 917.7 958.8 967.7 971.4 6224.2 6521.3 6528.3 6575.1 6617.0 433.0 433.8 437.5 467.5 471.3 4258.9 4319.0 4340.3 4389.5 4421.1 11316.0 11485.0 11565.2 11642.1 11726.5 11466.8 11467.9 11488.2 11571.4 11577.5 8706.5 9027.1 9034.1 9210.6 9233.9 6419.9 6858.2 6867.8 6927.0 6938.5 11185.7 11472.0 11528.0 11626.7 11708.3 11391.4 11684.6 11730.8 11793.8 11794.3 7921.5 8447.5 8510.7 8590.2 8636.1 9779.8 9855.0 9890.8 9938.6 9941.9 8652.3 8933.2 8940.3 8976.2 9034.6 8576.8 8606.5 8673.9 8722.3 8885.6 7792.6 7827.1 7864.5 7873.4 7883.4 5329.5 5482.4 5549.9 5585.2 5629.0 5386.3 5454.9 5505.8 5689.6 5855.0 02:53:12 INFO - PROCESS | 3468 | 02:53:12 INFO - PROCESS | 3468 | [#4] prototype.html Cycles:180 Average:4795.06 Median:5492.09 stddev:1423.53 (25.9%) stddev-sans-first:1387.48 02:53:12 INFO - PROCESS | 3468 | Values: 328.1 337.8 343.2 348.9 352.6 5402.2 5403.8 5418.9 5432.1 5469.8 5349.1 5366.9 5369.4 5401.0 5425.5 4037.9 4221.8 4229.6 4235.5 4254.1 4050.6 4232.7 4239.7 4254.1 4257.9 4202.9 4212.6 4215.3 4215.6 4216.3 4040.3 4097.6 4196.5 4200.6 4243.4 3518.8 3740.7 3747.1 3768.1 3774.8 5201.3 5201.9 5213.2 5218.5 5220.1 4704.2 4826.6 4850.4 4864.2 4869.3 5569.6 5613.8 5614.4 5632.7 5643.4 4167.3 4180.3 4186.7 4194.6 4198.4 5591.9 5824.9 5942.5 5947.1 5951.8 4132.2 4139.8 4141.4 4161.5 4170.5 4167.5 4182.7 4187.3 4188.2 4204.2 4651.8 4736.9 4743.4 4785.8 4821.0 5612.7 5649.7 5663.7 5670.8 5672.0 1422.6 1439.2 1440.1 1457.6 1460.2 901.8 913.7 918.2 918.2 931.6 5027.4 5386.7 5507.8 5642.5 5646.3 5810.9 5824.7 5836.1 5857.0 5861.6 5349.0 5583.9 5623.2 5656.7 5678.2 3055.3 3068.5 3109.5 3111.0 3118.0 6113.9 6126.4 6136.8 6150.0 6171.7 5636.7 5932.6 5992.2 6010.6 6030.3 6152.6 6185.7 6191.8 6197.6 6214.7 5607.8 5832.5 5889.7 5893.3 5899.4 5819.2 5830.5 5855.3 5855.6 5865.5 6179.5 6214.8 6226.6 6260.4 6274.6 4048.5 4235.6 4251.1 4257.4 4266.8 5754.6 5769.2 5775.7 5814.3 5824.9 5439.4 5667.7 5682.5 5700.8 5703.2 5620.7 5675.3 5692.9 5715.5 5718.5 5482.3 5501.9 5508.4 5541.2 5554.6 5472.9 5514.4 5712.8 5736.8 5753.9 5581.7 5637.5 5637.9 5643.8 5644.4 02:53:12 INFO - PROCESS | 3468 | 02:53:12 INFO - PROCESS | 3468 | [#5] yui.html Cycles:180 Average:21000.96 Median:4647.74 stddev:30505.81 (656.4%) stddev-sans-first:30553.41 02:53:12 INFO - PROCESS | 3468 | Values: 728.7 781.9 785.9 800.0 805.4 14748.0 14846.9 14866.4 14874.5 15093.1 14017.6 14111.6 14129.0 14135.9 14138.1 723.1 843.2 865.7 871.1 871.9 862.0 862.8 863.0 867.3 871.2 909.8 919.0 919.1 919.1 919.5 754.7 894.1 904.8 919.3 922.5 685.6 685.7 685.8 685.8 685.9 14056.5 14103.4 14140.1 14140.9 14153.5 14773.5 14872.2 15116.5 15124.8 15208.3 13023.3 13123.9 13142.9 13215.9 13372.1 4640.2 4655.3 4670.6 4730.6 4793.6 74078.6 77319.0 78122.2 78660.2 79158.2 12305.9 12306.9 12365.7 12455.8 12460.6 22377.8 23452.9 23576.1 23589.1 23693.2 8758.8 8765.4 9085.6 9186.0 9247.9 4709.6 5153.2 5165.5 5168.5 5196.1 3985.4 4087.9 4090.0 4102.8 4104.9 628.4 681.0 694.8 703.1 727.0 561.7 627.5 670.7 778.6 786.1 10023.3 10373.4 10490.1 10543.9 10558.0 682.9 696.3 716.9 727.1 811.4 4465.2 4744.8 4805.2 4822.3 4905.1 100632.0 112660.4 116080.0 119982.4 120053.0 66293.3 101156.0 102487.0 104303.0 104738.0 90648.0 94069.5 94623.5 94707.0 94831.5 9205.7 9415.6 9495.4 9522.7 9549.4 51234.7 51376.7 51647.7 51987.7 52379.5 75216.6 78507.0 79219.0 80241.6 80939.2 12354.8 12449.6 12544.7 12681.6 12983.2 12744.0 13284.0 13451.0 13589.3 14097.6 12010.2 12041.1 12326.3 12385.0 12429.2 12447.1 12614.4 12729.2 12738.6 12746.3 11089.9 11508.2 11711.4 11725.5 11753.5 10177.6 10311.8 10448.6 10487.7 10502.3 10047.4 10064.9 10120.9 10166.5 10418.4 02:53:12 INFO - PROCESS | 3468 | -------- Summary: end -------- 02:53:12 INFO - PROCESS | 3468 | 02:53:13 INFO - TEST-INFO | 3468: exit 0 02:53:13 INFO - TEST-OK | dromaeo_css | took 1114759ms 02:53:13 INFO - TEST-START | kraken 02:53:13 INFO - operating with platform_type : linux_ 02:53:13 INFO - Initialising browser for kraken test... 02:53:13 INFO - TEST-INFO | started process 3658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDJ_OiG/profile http://localhost:36131/getInfo.html) 02:53:17 INFO - PROCESS | 3658 | __metrics Screen width/height:1600/1200 02:53:17 INFO - PROCESS | 3658 | colorDepth:24 02:53:17 INFO - PROCESS | 3658 | Browser inner width/height: 1024/697 02:53:17 INFO - PROCESS | 3658 | __metrics 02:53:18 ERROR - PROCESS | 3658 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:53:18 INFO - PROCESS | 3658 | console.error: PushService: 02:53:18 INFO - PROCESS | 3658 | stateChangeProcessEnqueue: Error transitioning state 02:53:18 INFO - PROCESS | 3658 | UnknownError 02:53:19 INFO - TEST-INFO | 3658: exit 0 02:53:19 INFO - Browser initialized. 02:53:19 INFO - Running cycle 1/1 for kraken test... 02:53:19 INFO - TEST-INFO | started process 3750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDJ_OiG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:30 INFO - PROCESS | 3750 | RSS: Main: 144814080 02:53:30 INFO - PROCESS | 3750 | 02:53:33 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36131/tests/kraken/driver.html?testName=audio-beat-detection) 02:53:34 INFO - PROCESS | 3750 | RSS: Main: 195072000 02:53:34 INFO - PROCESS | 3750 | 02:53:36 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36131/tests/kraken/driver.html?testName=audio-dft) 02:53:37 INFO - PROCESS | 3750 | RSS: Main: 193495040 02:53:37 INFO - PROCESS | 3750 | 02:53:40 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36131/tests/kraken/driver.html?testName=audio-fft) 02:53:40 INFO - PROCESS | 3750 | RSS: Main: 279220224 02:53:40 INFO - PROCESS | 3750 | 02:53:42 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36131/tests/kraken/driver.html?testName=audio-oscillator) 02:53:43 INFO - PROCESS | 3750 | RSS: Main: 187523072 02:53:43 INFO - PROCESS | 3750 | 02:53:45 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36131/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:46 INFO - PROCESS | 3750 | RSS: Main: 188489728 02:53:46 INFO - PROCESS | 3750 | 02:53:49 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36131/tests/kraken/driver.html?testName=imaging-darkroom) 02:53:49 INFO - PROCESS | 3750 | RSS: Main: 223342592 02:53:49 INFO - PROCESS | 3750 | 02:53:53 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36131/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:53 INFO - PROCESS | 3750 | RSS: Main: 223907840 02:53:53 INFO - PROCESS | 3750 | 02:53:56 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36131/tests/kraken/driver.html?testName=json-parse-financial) 02:53:57 INFO - PROCESS | 3750 | RSS: Main: 223531008 02:53:57 INFO - PROCESS | 3750 | 02:53:58 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36131/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:59 INFO - PROCESS | 3750 | RSS: Main: 201502720 02:53:59 INFO - PROCESS | 3750 | 02:54:00 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:54:01 INFO - PROCESS | 3750 | RSS: Main: 203120640 02:54:01 INFO - PROCESS | 3750 | 02:54:03 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:54:04 INFO - PROCESS | 3750 | RSS: Main: 209678336 02:54:04 INFO - PROCESS | 3750 | 02:54:06 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:54:07 INFO - PROCESS | 3750 | RSS: Main: 214528000 02:54:07 INFO - PROCESS | 3750 | 02:54:09 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:54:10 INFO - PROCESS | 3750 | RSS: Main: 213524480 02:54:10 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36131/tests/kraken/driver.html?testName=ai-astar) 02:54:12 INFO - PROCESS | 3750 | RSS: Main: 256327680 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | __start_tp_report 02:54:12 INFO - PROCESS | 3750 | _x_x_mozilla_page_load 02:54:12 INFO - PROCESS | 3750 | _x_x_mozilla_page_load_details 02:54:12 INFO - PROCESS | 3750 | |i|pagename|runs| 02:54:12 INFO - PROCESS | 3750 | |0;ai-astar;110;103;110;109;110;109;109;109;108;109 02:54:12 INFO - PROCESS | 3750 | |1;audio-beat-detection;150;123;126;186;124;124;155;123;151;124 02:54:12 INFO - PROCESS | 3750 | |2;audio-dft;161;163;160;162;160;161;161;161;164;159 02:54:12 INFO - PROCESS | 3750 | |3;audio-fft;75;73;76;130;74;75;75;75;96;75 02:54:12 INFO - PROCESS | 3750 | |4;audio-oscillator;85;84;117;85;85;84;127;85;85;134 02:54:12 INFO - PROCESS | 3750 | |5;imaging-gaussian-blur;117;116;116;117;117;116;116;117;117;117 02:54:12 INFO - PROCESS | 3750 | |6;imaging-darkroom;146;145;145;145;149;146;145;145;145;145 02:54:12 INFO - PROCESS | 3750 | |7;imaging-desaturate;94;95;94;94;95;96;96;96;96;96 02:54:12 INFO - PROCESS | 3750 | |8;json-parse-financial;51;50;50;51;52;52;52;51;50;52 02:54:12 INFO - PROCESS | 3750 | |9;json-stringify-tinderbox;61;59;59;59;59;59;59;60;60;60 02:54:12 INFO - PROCESS | 3750 | |10;stanford-crypto-aes;76;76;76;75;83;77;79;77;115;77 02:54:12 INFO - PROCESS | 3750 | |11;stanford-crypto-ccm;127;119;120;123;118;116;118;133;123;121 02:54:12 INFO - PROCESS | 3750 | |12;stanford-crypto-pbkdf2;158;157;167;157;157;160;152;153;157;155 02:54:12 INFO - PROCESS | 3750 | |13;stanford-crypto-sha256-iterative;61;61;61;62;61;61;61;62;60;60 02:54:12 INFO - PROCESS | 3750 | __end_tp_report 02:54:12 INFO - PROCESS | 3750 | __start_cc_report 02:54:12 INFO - PROCESS | 3750 | _x_x_mozilla_cycle_collect,1599 02:54:12 INFO - PROCESS | 3750 | __end_cc_report 02:54:12 INFO - PROCESS | 3750 | __startTimestamp1466502852477__endTimestamp 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | ------- Summary: start ------- 02:54:12 INFO - PROCESS | 3750 | Number of tests: 14 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:2.07 (1.9%) stddev-sans-first:2.13 02:54:12 INFO - PROCESS | 3750 | Values: 110.0 103.0 110.0 109.0 110.0 109.0 109.0 109.0 108.0 109.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:138.00 stddev:21.30 (15.4%) stddev-sans-first:22.19 02:54:12 INFO - PROCESS | 3750 | Values: 150.0 123.0 126.0 186.0 124.0 124.0 155.0 123.0 151.0 124.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 02:54:12 INFO - PROCESS | 3750 | Values: 161.0 163.0 160.0 162.0 160.0 161.0 161.0 161.0 164.0 159.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:18.03 (24.0%) stddev-sans-first:18.92 02:54:12 INFO - PROCESS | 3750 | Values: 75.0 73.0 76.0 130.0 74.0 75.0 75.0 75.0 96.0 75.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:85.00 stddev:20.35 (23.9%) stddev-sans-first:21.11 02:54:12 INFO - PROCESS | 3750 | Values: 85.0 84.0 117.0 85.0 85.0 84.0 127.0 85.0 85.0 134.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:54:12 INFO - PROCESS | 3750 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.00 stddev:1.26 (0.9%) stddev-sans-first:1.33 02:54:12 INFO - PROCESS | 3750 | Values: 146.0 145.0 145.0 145.0 149.0 146.0 145.0 145.0 145.0 145.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 02:54:12 INFO - PROCESS | 3750 | Values: 94.0 95.0 94.0 94.0 95.0 96.0 96.0 96.0 96.0 96.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.50 stddev:0.88 (1.7%) stddev-sans-first:0.93 02:54:12 INFO - PROCESS | 3750 | Values: 51.0 50.0 50.0 51.0 52.0 52.0 52.0 51.0 50.0 52.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:0.71 (1.2%) stddev-sans-first:0.50 02:54:12 INFO - PROCESS | 3750 | Values: 61.0 59.0 59.0 59.0 59.0 59.0 59.0 60.0 60.0 60.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:77.00 stddev:12.12 (15.7%) stddev-sans-first:12.72 02:54:12 INFO - PROCESS | 3750 | Values: 76.0 76.0 76.0 75.0 83.0 77.0 79.0 77.0 115.0 77.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.00 stddev:5.05 (4.1%) stddev-sans-first:4.99 02:54:12 INFO - PROCESS | 3750 | Values: 127.0 119.0 120.0 123.0 118.0 116.0 118.0 133.0 123.0 121.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:157.00 stddev:4.14 (2.6%) stddev-sans-first:4.38 02:54:12 INFO - PROCESS | 3750 | Values: 158.0 157.0 167.0 157.0 157.0 160.0 152.0 153.0 157.0 155.0 02:54:12 INFO - PROCESS | 3750 | 02:54:12 INFO - PROCESS | 3750 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 02:54:12 INFO - PROCESS | 3750 | Values: 61.0 61.0 61.0 62.0 61.0 61.0 61.0 62.0 60.0 60.0 02:54:12 INFO - PROCESS | 3750 | -------- Summary: end -------- 02:54:12 INFO - PROCESS | 3750 | 02:54:13 INFO - TEST-INFO | 3750: exit 0 02:54:13 INFO - TEST-OK | kraken | took 60018ms 02:54:13 INFO - SUITE-END | took 1174s 02:54:13 INFO - Completed test suite (00:19:35) 02:54:13 INFO - javascript benchmark 02:54:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3355.1612096975755, 3369.292448585797, 3382.6109997350304, 3399.9320013599745, 3423.0928803866977, 5536.695481748502, 5618.803341883035, 5633.21135041094, 5640.802571909984, 5655.349634792, 5602.411746766582, 5651.9152212716845, 5658.207850900877, 5659.207710920464, 5661.4621610947, 4874.268859671042, 4968.801247950078, 5081.542661160494, 5083.034223497533, 5123.052235336456, 5015.7492125393765, 5029.698218106907, 5040.621953353513, 5067.695938243699, 5147.871303217412, 5039.21892106724, 5045.318881950926, 5072.985402919412, 5144.09978253806, 5157.5358217760395, 5084.694918304914, 5122.513361230677, 5131.897362052738, 5137.999999999981, 5168.974155129238, 4917.213245880642, 4951.306817045581, 5009.373828271466, 5027.2207807789855, 5047.041062198171, 5551.528120109796, 5569.526590239834, 5574.1917421973585, 5591.189277554732, 5633.32400111985, 6016.8194954151, 6021.668808215546, 6032.396760323976, 6060.484858787008, 6065.059915713027, 5763.1355296705415, 5901.4098590141075, 5926.585139040269, 5956.940430595682, 6044.2746870375395, 5634.492895639371, 5665.943340566583, 5668.971655141698, 5669.688167150846, 5673.517750991171, 5965.3139888912465, 6155.199824022849, 6158.507319414436, 6164.938350616526, 6168.9691551541955, 5720.0, 5783.190353350535, 5792.739326730307, 5875.823725288248, 5896.292444906639, 5913.970430147908, 5928.199693041471, 5939.613925094855, 5950.851228719317, 5959.374265702126, 5786.855328616818, 5788.7684492620665, 5835.4748072673665, 5894.204282421818, 5900.675462849498, 5850.385709500526, 5908.586398952118, 5909.940900590939, 5917.349091599921, 5948.315943666447, 4590.862274131715, 4600.631949444037, 4602.424696912886, 4606.124836281096, 4620.745858977722, 4037.6769858411258, 4051.534073581517, 4053.108316170438, 4122.42286079949, 4164.541900390955, 5743.0, 5774.0, 5774.740136693859, 5780.566457515703, 5802.88394232113, 5926.081457374114, 5964.254468191476, 5976.223090998143, 5976.850578735566, 5993.670348130808, 5632.436756324417, 5736.1682556029145, 5776.595638305278, 5782.190493330937, 5784.132380143013, 5271.736413179402, 5277.445868183862, 5280.815171469057, 5286.9471305287225, 5295.735213239323, 6380.521460890452, 6395.072714456378, 6396.168498095218, 6398.0402939559435, 6400.935990640127, 5803.448672376117, 5860.0, 5919.4080591940465, 5933.614315069507, 6032.034874420072, 6289.96855015722, 6303.149074874833, 6324.146240257506, 6324.778632747832, 6330.177076979963, 5913.91129133072, 5915.053591425351, 5918.260217472816, 5919.348871624032, 5959.553033522589, 5750.5112065474905, 5904.114382842608, 5907.675077870586, 5982.7307771149535, 6042.3655516170165, 5887.116932460165, 5893.616914900518, 5896.14505896634, 5898.705064746831, 5900.616459930091, 5745.798897038583, 5867.119932010062, 5876.08920617305, 5876.735546900314, 5877.23595932526, 5623.971880140573, 5626.043572592587, 5651.604387692986, 5704.2014118024335, 5724.513416359489, 5872.970635146797, 5944.791932282349, 5946.583739138218, 5949.018411962151, 5958.0, 5581.972090139523, 5670.914936275876, 5782.653040817564, 5786.652800831964, 5792.652440853562], "value": 5528.326644894866, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.9000264956283, 648.4002297874466, 657.2802780954855, 669.307266978677, 671.7010930136091, 32445.351092978126, 35103.47344789827, 45339.31991020129, 46268.07463850721, 46341.30488042674, 47288.290675639895, 47688.52311476884, 47865.0, 47865.52134478654, 47873.7606311968, 9085.227755640763, 9290.860637090449, 9292.488913109777, 9296.8605470918, 9300.674476393327, 8408.915910840906, 10771.24601277911, 11033.393163376011, 11052.0, 11387.715307117305, 11175.161862860277, 11255.324680519154, 11257.380844053574, 11263.098952083814, 11263.380514071723, 8488.618012189467, 10812.405317707522, 11046.668599942015, 11126.054285385711, 11129.888701112966, 10961.61634342802, 11043.337399756041, 11052.281601695864, 11059.0, 11061.225714200009, 41575.0, 41914.0, 41964.160716785496, 41996.0, 41998.79000605008, 3731.104534911629, 3769.6418840210135, 3791.563970143414, 3896.7272290939645, 3922.3332033554366, 32795.0, 33126.33747325064, 33452.49821252683, 33487.6651233487, 33620.49569256463, 4482.153189281913, 4550.089982003579, 4588.587027167571, 4623.8150473981, 4633.235516139866, 349272.0, 349837.0, 350060.0, 350854.99999999744, 351522.0, 59244.0, 59875.0, 59925.40074599198, 60056.39943600595, 60126.699366502886, 37921.431178532344, 38494.230115397535, 38511.0, 40624.0, 40709.79645101756, 16649.0, 16693.499195024167, 16734.916325418297, 16738.581535461468, 16761.83238167627, 11749.353785541707, 12035.699107522381, 12134.15060945743, 12566.308853013172, 12646.936765316115, 20376.694349584766, 20567.8971605141, 20581.353491720627, 20595.794042059686, 20602.072906719233, 7269.563826170341, 7303.780886573411, 7305.488615796843, 7538.434617403716, 7627.771166865003, 1062.3838173859144, 1180.9114316426303, 1185.1763024697752, 1198.7782260281876, 1230.7692307692307, 33338.499922501185, 33849.66150338514, 33893.66106338905, 33986.0, 34379.312413752086, 1107.4850194659523, 1158.8339917994795, 1160.5647882044234, 1220.1093201962617, 1259.9559015434415, 16627.251773670214, 16702.331906723593, 16877.36757784617, 16955.406560770312, 17252.309907603805, 595563.0, 597830.0, 600392.0, 600891.0, 602233.0, 57435.0, 57837.13244301339, 58001.70999145062, 58016.0, 58126.4187358121, 1367.5145323410047, 1459.0807791091545, 1490.4708828365774, 1493.1862135136378, 1501.5045035138378, 31881.68118318787, 33372.58584623969, 33396.0, 34007.659923400446, 34774.13064673403, 50715.0, 51428.0, 51428.22857657063, 51444.0, 51531.74234128955, 453800.0, 456405.0, 456964.0, 457808.0, 459880.0, 25195.622065668664, 29019.27451813637, 29122.417551649272, 30738.692613073585, 30884.22789430282, 48687.26969095537, 49222.75388623034, 49858.25212621741, 49900.0, 50600.0, 40750.59249407586, 41256.58743412527, 41393.79303103465, 42632.78683606562, 43494.56505434905, 40792.184156316114, 41566.37650435185, 41859.7907010463, 42266.36600450934, 42349.0, 41128.38307425451, 41223.381649275885, 44138.0, 44218.77890610526, 44327.778361109275, 36661.266774663825, 38727.0, 39413.60586394214, 39630.2073958525, 40230.59769402268, 29228.853855730584, 29299.7070029297, 29632.0, 29972.70027299699, 30000.0], "value": 21004.53702312671, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.4773209621924, 419.1930533722584, 420.80222295521094, 427.1030835245984, 437.31560108430307, 18902.716459253104, 19754.506137346554, 20309.086091125897, 21037.894810525926, 21639.56720865582, 17263.223154958025, 18834.434966951012, 19938.102785374693, 20601.690974635392, 20655.483612909684, 5724.68514231716, 5927.703614819264, 5959.493443057346, 5960.0761881908375, 5966.164736936832, 4229.323308270677, 4365.738055716667, 5808.1287806829105, 5920.52635789138, 6328.715207815636, 6597.076409302702, 6684.565503242274, 6699.832504187386, 6710.29541898101, 6719.2272888617945, 6535.509836762238, 6549.541532092755, 6593.20881494219, 6607.93392066078, 6649.9667501662425, 3965.8017099144927, 4153.792310384499, 4155.293600087962, 5891.705414729289, 5900.911486327708, 21842.907854607365, 22521.549569008526, 22747.886260568757, 23856.880715596486, 24064.398390040387, 2434.914777982762, 2647.1926062550915, 2717.7961652876115, 2996.8951086712077, 3021.7884748067645, 14317.856821431757, 15076.924615376962, 15164.696706065928, 15289.311980960883, 15377.154256515887, 2028.239410221167, 2029.2288930206428, 2119.851610387258, 2133.0, 2155.698202251686, 60286.397136028514, 63405.36594634041, 69612.30387696109, 72575.63712181458, 84796.57601711951, 11058.170637202242, 11255.718607034889, 11298.435078246219, 11390.601328953448, 11395.94302028501, 15832.208389580475, 15922.203889805463, 15940.681186376207, 15954.441594544136, 15978.360865565479, 8473.95763021181, 8524.0, 8558.95720521406, 8620.396572239883, 8771.912280877237, 8081.393895457864, 8163.346932245406, 8316.0, 8471.745847624581, 8485.830283394298, 6778.356056174655, 7034.964825175944, 7057.788266352018, 7072.575645461289, 7122.679479423438, 1928.431112821721, 1950.9414717558495, 1971.6056788642043, 2035.765886922993, 2056.0, 466.56842420761336, 871.8169184471332, 1012.3622118065572, 1059.21618002679, 1061.0185578340004, 11370.545178192946, 11876.76246475083, 12100.515979360904, 12590.937045314715, 12640.494380224687, 458.3331253026838, 477.72530794793136, 494.8540180646718, 496.7913476339946, 503.70029832249753, 6631.86736265272, 6714.630695311707, 6734.023566582916, 6758.594484330956, 6775.017622444817, 565734.0, 591676.0, 592509.0, 596835.0, 598302.0, 64419.677901610194, 91920.0, 104433.0, 105282.0, 107140.46429767802, 479.1566842357406, 484.26150121064956, 486.5329283887437, 487.59529590439143, 490.60016086889783, 11185.776284474428, 11358.26171298863, 11375.829362559734, 11395.145364097893, 11413.60052398162, 39555.2088958225, 40655.59344406518, 41011.38482922699, 42083.7895810519, 42210.36684449797, 59399.40600593939, 60442.39557604368, 62341.688291558254, 62763.37236627758, 63434.0, 7900.486468379537, 8293.668253269801, 8324.958375208327, 8958.82082358336, 9273.582688778886, 10330.0, 13611.931940340235, 13951.720965580835, 13971.650708732363, 14090.78863817023, 11886.940565297118, 12148.271103733805, 12158.635240942785, 12170.817437738264, 12559.93720031394, 11905.345206013752, 11950.880491195325, 11990.100742444178, 12074.75850483003, 12330.568430104904, 12339.07456940751, 12361.62915112548, 12530.874691253335, 12596.622101336974, 12598.433070511666, 7928.326092282221, 7996.880046799419, 8015.639296231567, 8063.55650439208, 8117.959410202911, 11219.382933938712, 12228.87771122313, 12240.571579994657, 12468.127231094099, 12563.057770667054], "value": 8910.639907217874, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.9504417345395, 1582.525242427272, 1592.482443205958, 1788.30256200082, 1927.1809480970592, 9219.446833190013, 9487.952560237198, 9531.237500999929, 9782.755431114225, 9783.364081334708, 9559.952200239006, 9749.268804839649, 9763.804723905518, 9766.560504777284, 9768.218542516599, 2178.302943058222, 2330.33585428153, 2392.8803559822027, 2476.8266221364465, 2510.63595778612, 2505.24842547236, 2515.7987361011074, 2518.9748102518924, 2519.370157460635, 2520.2565243253193, 2421.9152329668464, 2454.3864033991504, 2468.7778099971, 2472.7527247275307, 2479.7396273391305, 2116.7777383374755, 2182.4216582605623, 2185.508260641359, 2358.50471401006, 2387.1048356866177, 2363.645453182019, 2396.928092157221, 2398.100712232913, 2402.3994001499627, 2406.759324067597, 9636.132748052709, 9708.708738737849, 9730.951345243298, 9736.805263894754, 9740.561674724584, 5561.360443549003, 5664.235328230678, 5673.943260567424, 5687.431256874321, 5691.117876729114, 3533.1343820764077, 3623.4564815277918, 3628.219932714479, 3828.157805282833, 3844.308024555579, 1103.7516558774212, 1111.1888321525332, 1124.0497736427292, 1146.3752255021034, 1158.507634255438, 13915.443382264697, 13925.23411212383, 13953.930230348884, 13993.510227142104, 14031.508897188549, 4959.479254678279, 5027.195648696191, 5036.647434679538, 5055.292259083732, 5150.4334523202415, 11623.244489108181, 11625.069994400428, 11665.88334116665, 11667.533298667959, 11682.357470339213, 5844.415558444207, 5874.412558744091, 5884.588078834526, 5886.6173698709445, 5891.086881533369, 4820.638452116105, 5256.737163141827, 5363.892722145613, 5379.112446446371, 5424.240606315119, 4257.70196086271, 4273.059926816096, 4354.063876266618, 4376.365427013129, 4382.956170438255, 1291.0768800307826, 1298.0653929170983, 1302.6808431934048, 1323.2391374959436, 1326.383231797219, 914.4970266353612, 917.7246825952187, 958.8034452937131, 967.666155176463, 971.3589031239349, 6224.221972253468, 6521.315261897433, 6528.314526974599, 6575.079488871562, 6617.0, 433.02137169996035, 433.7722695584843, 437.5427678076418, 467.47642640243146, 471.32129733184104, 4258.893527661833, 4319.0, 4340.327249276367, 4389.4513185851765, 4421.071574969228, 11316.0, 11485.0, 11565.190436669352, 11642.126840486997, 11726.472308746126, 11466.770664586662, 11467.885321146849, 11488.195826292247, 11571.42142892852, 11577.479013444416, 8706.47761134334, 9027.14242146995, 9034.096590341045, 9210.585523651453, 9233.861492077624, 6419.935800641933, 6858.211305699909, 6867.828304292432, 6927.0, 6938.5143039986715, 11185.66443006711, 11472.0, 11528.0, 11626.70933226676, 11708.297502149557, 11391.430428478709, 11684.591039313584, 11730.824037639271, 11793.764124717629, 11794.29234245948, 7921.524708517507, 8447.535385553854, 8510.723391491325, 8590.226879580869, 8636.093210212837, 9779.755506112404, 9855.0, 9890.752731181778, 9938.602455901972, 9941.900580994386, 8652.307815374881, 8933.15135062168, 8940.329475289249, 8976.192142707188, 9034.638614455349, 8576.828463430822, 8606.483610983361, 8673.869891951499, 8722.25860801839, 8885.644574217218, 7792.61036948139, 7827.060752709711, 7864.5281283123195, 7873.409494287836, 7883.369330453665, 5329.520343169133, 5482.369527504388, 5549.889002219852, 5585.1901474286815, 5628.971855140862, 5386.299781028441, 5454.945450545444, 5505.752241149078, 5689.630174038674, 5855.03391940325], "value": 4921.614544088096, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.0682860675682, 337.75006495193566, 343.229449885008, 348.9075395020319, 352.6262162108165, 5402.243685883975, 5403.8108666196695, 5418.864528386793, 5432.13085906255, 5469.753861076251, 5349.144136938091, 5366.91949620756, 5369.40936496985, 5401.002443643776, 5425.511703946644, 4037.9394309085387, 4221.804661575979, 4229.646513115797, 4235.470566179228, 4254.127903779718, 4050.6151915567975, 4232.703710740249, 4239.682023848209, 4254.085661452344, 4257.850975215868, 4202.852900148496, 4212.578742125794, 4215.3255479123345, 4215.641670458, 4216.304309788881, 4040.2525532776235, 4097.569755175723, 4196.538380778112, 4200.558941311149, 4243.448351714288, 3518.7888726676483, 3740.7007439404783, 3747.0819649186124, 3768.1144930941205, 3774.8298027611527, 5201.28357641981, 5201.8959620807755, 5213.165893457029, 5218.538809133449, 5220.060389129955, 4704.200285951397, 4826.589739872115, 4850.4236123259725, 4864.173090574611, 4869.318295438641, 5569.554435645138, 5613.831585052455, 5614.3543492498475, 5632.718364081779, 5643.407442218549, 4167.291560434734, 4180.310248808943, 4186.6859985500905, 4194.559571245006, 4198.412222288882, 5591.916121258185, 5824.854378640525, 5942.465178133945, 5947.1376650385455, 5951.791687290924, 4132.152908653718, 4139.81370838313, 4141.440905477722, 4161.521425036099, 4170.457840480718, 4167.458230430025, 4182.749035057906, 4187.267228235047, 4188.204241194163, 4204.159168166379, 4651.837185698484, 4736.881577960509, 4743.359646447754, 4785.760711964388, 4820.975895120572, 5612.691301978349, 5649.728811017489, 5663.688497132614, 5670.829875103754, 5672.0, 1422.5945605502382, 1439.2443966917451, 1440.1071335771678, 1457.6210185351886, 1460.1677044084981, 901.7925877048316, 913.6847787513298, 918.169057003413, 918.205752024494, 931.6226928094133, 5027.421846487628, 5386.703731294738, 5507.752151153128, 5642.463965923231, 5646.317998950548, 5810.912836307459, 5824.708764561839, 5836.066229403275, 5857.0, 5861.6189947653265, 5349.037173308764, 5583.939051580187, 5623.184638227516, 5656.660600363992, 5678.205051292823, 3055.297281625194, 3068.5397190421168, 3109.5335699645234, 3110.9533356999664, 3117.973317343745, 6113.908291375633, 6126.356732543019, 6136.754529818846, 6149.96925015372, 6171.65477118692, 5636.718164091861, 5932.614380065282, 5992.221011268507, 6010.639361638228, 6030.33666296707, 6152.569320147636, 6185.659788711574, 6191.783287584913, 6197.566170368031, 6214.720337584729, 5607.80372686954, 5832.533397328119, 5889.734961926638, 5893.292804863444, 5899.410058994066, 5819.243498345188, 5830.47525722687, 5855.306558982916, 5855.619384739978, 5865.501432378295, 6179.505639548735, 6214.751409943552, 6226.564140510302, 6260.373962603703, 6274.560780745486, 4048.4939382577177, 4235.618794308527, 4251.086016506466, 4257.361395790656, 4266.786660666892, 5754.56840736938, 5769.163471296554, 5775.6823374714795, 5814.273215848019, 5824.893270278633, 5439.374471935778, 5667.744951477111, 5682.516986056066, 5700.771969121189, 5703.230063941481, 5620.747066382104, 5675.347335056521, 5692.914606280992, 5715.485606295453, 5718.456746609066, 5482.28730265079, 5501.889962200814, 5508.44915508446, 5541.224228608079, 5554.555815487922, 5472.945270547243, 5514.36584792754, 5712.80031193454, 5736.799212027559, 5753.913691294718, 5581.74882130297, 5637.5489960802215, 5637.887242255214, 5643.830685079454, 5644.350899646429], "value": 4338.133850073534, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.7158008376731, 781.9218078192185, 785.9331956783673, 799.9760007199784, 805.3516918880299, 14748.0, 14846.925765371185, 14866.405343786235, 14874.479393221212, 15093.094414335133, 14017.649558761035, 14111.576652700409, 14129.0, 14135.929320353409, 14138.08102473341, 723.1430754555868, 843.2368706320759, 865.7186414415308, 871.0505548951658, 871.9302455803552, 861.9525926074064, 862.8015556422026, 863.0118514301122, 867.2801574693021, 871.1593312453481, 909.8271328447573, 918.9862152067724, 919.0533750237266, 919.1130559010553, 919.5034681272139, 754.7320701151094, 894.0612357025097, 904.8461761500561, 919.342669990953, 922.5202894494893, 685.5715178013742, 685.7051467868814, 685.7736946807541, 685.8456847209388, 685.9142607174103, 14056.508022219276, 14103.435862565486, 14140.080894741912, 14140.92929535356, 14153.504627337994, 14773.482928097465, 14872.182029988346, 15116.54650360491, 15124.773128402972, 15208.315625796755, 13023.28371939543, 13123.86876131236, 13142.934285328607, 13215.867841321657, 13372.095907604824, 4640.211164102111, 4655.2784318430695, 4670.556297151765, 4730.574248317634, 4793.640476964207, 74078.62960685216, 77319.0, 78122.21877781206, 78660.21339786587, 79158.20841791623, 12305.93847030777, 12306.876931230752, 12365.690857728629, 12455.813162802566, 12460.626181214579, 22377.776222237568, 23452.882735586212, 23576.0569577215, 23589.0564377423, 23693.17073902405, 8758.824823503493, 8765.430247033923, 9085.591148398205, 9186.0, 9247.861282080774, 4709.552592503706, 5153.17549192135, 5165.483451654804, 5168.53483186515, 5196.064708352457, 3985.362342025262, 4087.9386809197886, 4089.97955010229, 4102.774347410861, 4104.856330028435, 628.4375483941938, 681.0431343961742, 694.8019814352886, 703.1421665567999, 726.989095163573, 561.7472137538124, 627.4603840696997, 670.6948338505968, 778.6496076765478, 786.0645831460544, 10023.348482348623, 10373.377597344033, 10490.108340790966, 10543.894561054445, 10558.0, 682.9180498340131, 696.2828286864537, 716.9032180655545, 727.0875051809944, 811.4279432999721, 4465.218586747306, 4744.786484608201, 4805.183118869801, 4822.324874517571, 4905.117078925757, 100632.0, 112660.43669781598, 116080.0, 119982.40008800075, 120053.0, 66293.33706662872, 101156.0, 102487.0, 104303.0, 104738.0, 90648.0, 94069.5296523513, 94623.52688236652, 94707.0, 94831.52584236897, 9205.677801277192, 9415.576299066695, 9495.382800118246, 9522.714318570454, 9549.427034377959, 51234.74382628063, 51376.743116285674, 51647.741761290956, 51987.74006130097, 52379.476205238985, 75216.62391688007, 78507.0, 79219.0, 80241.59879200567, 80939.19060809317, 12354.814677780021, 12449.564265250672, 12544.74910501803, 12681.619551413472, 12983.221006739626, 12744.0, 13284.0, 13451.0, 13589.320533973065, 14097.647558811112, 12010.219335743148, 12041.09691773103, 12326.260424374566, 12385.0, 12429.192102513307, 12447.128700990843, 12614.432350544064, 12729.236245825281, 12738.554150604685, 12746.298953557643, 11089.88910110921, 11508.194426390073, 11711.355875426932, 11725.472353744273, 11753.529858805894, 10177.643782467874, 10311.793764124526, 10448.634297799541, 10487.737806554896, 10502.317349372266, 10047.397156170653, 10064.899351006396, 10120.949395252977, 10166.542505587118, 10418.374897506174], "value": 7686.450616204285, "unit": "score"}], "name": "dromaeo_css", "value": 7441.590889357028, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 108.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 126.0, 186.0, 124.0, 124.0, 155.0, 123.0, 151.0, 124.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 162.0, 160.0, 161.0, 161.0, 161.0, 164.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 76.0, 130.0, 74.0, 75.0, 75.0, 75.0, 96.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 85.0, 85.0, 84.0, 127.0, 85.0, 85.0, 134.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 149.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 51.0, 52.0, 52.0, 52.0, 51.0, 50.0, 52.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 75.0, 83.0, 77.0, 79.0, 77.0, 115.0, 77.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 119.0, 120.0, 123.0, 118.0, 116.0, 118.0, 133.0, 123.0, 121.0], "value": 121.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 167.0, 157.0, 157.0, 160.0, 152.0, 153.0, 157.0, 155.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 60.0, 60.0], "value": 61.0, "unit": "score"}], "name": "kraken", "value": 1477.1, "alertThreshold": 2.0}]} 02:54:13 INFO - Return code: 0 02:54:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:54:13 ERROR - # TBPL SUCCESS # 02:54:13 INFO - Running post-action listener: _resource_record_post_action 02:54:13 INFO - ##### 02:54:13 INFO - ##### Finished run-tests step (success) 02:54:13 INFO - ##### 02:54:13 INFO - Running post-run listener: _resource_record_post_run 02:54:13 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7929856; Write bytes: 391569408; Read time: 1660; Write time: 292008 02:54:13 INFO - TinderboxPrint: CPU usage
13.0% 02:54:13 INFO - TinderboxPrint: I/O read bytes / time
7,929,856 / 1,660 02:54:13 INFO - TinderboxPrint: I/O write bytes / time
391,569,408 / 292,008 02:54:13 INFO - TinderboxPrint: CPU idle
8,273.4 (87.0%) 02:54:13 INFO - TinderboxPrint: CPU user
1,195.9 (12.6%) 02:54:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:54:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15351808; Read time: 0; Write time: 7308 02:54:13 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6168576; Write bytes: 376217600; Read time: 1616; Write time: 284700 02:54:14 INFO - Running post-run listener: _upload_blobber_files 02:54:14 INFO - Blob upload gear active. 02:54:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:54:14 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 02:54:14 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'] 02:54:14 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 02:54:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:54:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:54:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:54:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:15 INFO - (blobuploader) - INFO - Done attempting. 02:54:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:54:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:54:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:18 INFO - (blobuploader) - INFO - Done attempting. 02:54:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:54:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:19 INFO - (blobuploader) - INFO - Done attempting. 02:54:19 INFO - (blobuploader) - INFO - Iteration through files over. 02:54:19 INFO - Return code: 0 02:54:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:54:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:54:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bc48daf01d6505a40a52e1357baa8171316241d8690aafd6490b398e5880f9983621a6ac5e7253ca4d953f5a570b759cce3ff4b1dba506eeaa45494861115aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212e6a5c1faf79c31312226d0368c6c694b9736a672605d65f240462905285a9b52a18ab9922b4ba7e3af52c94d7915c1a2816dae15d352fa2e9b895a23175a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6fa85890fd47d907cb8eca0d2db4b519507dde494f4c66c8fb1eae1c0c7ed09ddac1acfb1d00efe29367001f2737036e1619c8e53fd2221b656aa29ebc05607"} 02:54:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:54:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:54:19 INFO - Contents: 02:54:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bc48daf01d6505a40a52e1357baa8171316241d8690aafd6490b398e5880f9983621a6ac5e7253ca4d953f5a570b759cce3ff4b1dba506eeaa45494861115aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212e6a5c1faf79c31312226d0368c6c694b9736a672605d65f240462905285a9b52a18ab9922b4ba7e3af52c94d7915c1a2816dae15d352fa2e9b895a23175a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6fa85890fd47d907cb8eca0d2db4b519507dde494f4c66c8fb1eae1c0c7ed09ddac1acfb1d00efe29367001f2737036e1619c8e53fd2221b656aa29ebc05607"} 02:54:19 INFO - Running post-run listener: copy_logs_to_upload_dir 02:54:19 INFO - Copying logs to upload dir... 02:54:19 INFO - mkdir: /builds/slave/test/build/upload/logs 02:54:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.667162 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-21 02:54:19.668814) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 02:54:19.671985) ========= 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=6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296 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/1bc48daf01d6505a40a52e1357baa8171316241d8690aafd6490b398e5880f9983621a6ac5e7253ca4d953f5a570b759cce3ff4b1dba506eeaa45494861115aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212e6a5c1faf79c31312226d0368c6c694b9736a672605d65f240462905285a9b52a18ab9922b4ba7e3af52c94d7915c1a2816dae15d352fa2e9b895a23175a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6fa85890fd47d907cb8eca0d2db4b519507dde494f4c66c8fb1eae1c0c7ed09ddac1acfb1d00efe29367001f2737036e1619c8e53fd2221b656aa29ebc05607"} build_url:https://queue.taskcluster.net/v1/task/dObwata4TVOS1OcY1SQOlg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/dObwata4TVOS1OcY1SQOlg/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/1bc48daf01d6505a40a52e1357baa8171316241d8690aafd6490b398e5880f9983621a6ac5e7253ca4d953f5a570b759cce3ff4b1dba506eeaa45494861115aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/212e6a5c1faf79c31312226d0368c6c694b9736a672605d65f240462905285a9b52a18ab9922b4ba7e3af52c94d7915c1a2816dae15d352fa2e9b895a23175a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6fa85890fd47d907cb8eca0d2db4b519507dde494f4c66c8fb1eae1c0c7ed09ddac1acfb1d00efe29367001f2737036e1619c8e53fd2221b656aa29ebc05607"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 02:54:19.697362) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:54:19.697702) ========= 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=6dbc10da6d83fee962c624be000001a8-1466501293.211257-720267296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:54:19.781891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 02:54:19.782243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 02:54:19.782585) ========= ========= Total master_lag: 0.17 =========