builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1465562494.35 results: success (0) buildid: 20160610030239 builduid: 24c9737725dd49398922c66457171ff8 revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:34.355385) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:34.355950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-06-10 05:41:34.356275) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-06-10 05:41:36.202018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:36.202304) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 05:41:36-- 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% 103M=0s 2016-06-10 05:41:36 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101385 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:36.317467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:36.317823) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017424 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:36.483619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:36.483938) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ccccf8e5036179a3178437cabc154b5e04b333d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3ccccf8e5036179a3178437cabc154b5e04b333d --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=9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 05:41:36,882 truncating revision to first 12 chars 2016-06-10 05:41:36,882 Setting DEBUG logging. 2016-06-10 05:41:36,883 attempt 1/10 2016-06-10 05:41:36,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ccccf8e5036?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 05:41:37,189 unpacking tar archive at: mozilla-central-3ccccf8e5036/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629304 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:37.126359) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:37.126676) ========= script_repo_revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:37.127072) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:37.127350) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:37.137121) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-10 05:41:37.137402) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:41:37 INFO - MultiFileLogger online at 20160610 05:41:37 in /builds/slave/test 05:41:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:41:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:41:37 INFO - {'append_to_log': False, 05:41:37 INFO - 'base_work_dir': '/builds/slave/test', 05:41:37 INFO - 'blob_upload_branch': 'Firefox', 05:41:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:41:37 INFO - 'branch': 'Firefox', 05:41:37 INFO - 'buildbot_json_path': 'buildprops.json', 05:41:37 INFO - 'config_files': ('talos/linux_config.py',), 05:41:37 INFO - 'default_actions': ('clobber', 05:41:37 INFO - 'read-buildbot-config', 05:41:37 INFO - 'download-and-extract', 05:41:37 INFO - 'populate-webroot', 05:41:37 INFO - 'create-virtualenv', 05:41:37 INFO - 'install', 05:41:37 INFO - 'run-tests'), 05:41:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:41:37 INFO - 'download_minidump_stackwalk': True, 05:41:37 INFO - 'download_symbols': 'ondemand', 05:41:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:41:37 INFO - 'tooltool.py': '/tools/tooltool.py', 05:41:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:41:37 INFO - '/tools/misc-python/virtualenv.py')}, 05:41:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:41:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:41:37 INFO - 'installer_path': 'installer.exe', 05:41:37 INFO - 'log_level': 'info', 05:41:37 INFO - 'log_name': 'talos', 05:41:37 INFO - 'log_to_console': True, 05:41:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:41:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:41:37 INFO - 'opt_config_files': (), 05:41:37 INFO - 'pip_index': False, 05:41:37 INFO - 'sps_profile': False, 05:41:37 INFO - 'sps_profile_interval': 0, 05:41:37 INFO - 'suite': 'dromaeojs-e10s', 05:41:37 INFO - 'system_bits': '32', 05:41:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:41:37 INFO - 'title': 'talos-linux64-ix-040', 05:41:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:41:37 INFO - 'use_talos_json': True, 05:41:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:41:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:41:37 INFO - 'work_dir': 'build'} 05:41:37 INFO - ##### 05:41:37 INFO - ##### Running clobber step. 05:41:37 INFO - ##### 05:41:37 INFO - Running pre-action listener: _resource_record_pre_action 05:41:37 INFO - Running main action method: clobber 05:41:37 INFO - rmtree: /builds/slave/test/build 05:41:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:41:38 INFO - Running post-action listener: _resource_record_post_action 05:41:38 INFO - ##### 05:41:38 INFO - ##### Finished clobber step (success) 05:41:38 INFO - ##### 05:41:38 INFO - ##### 05:41:38 INFO - ##### Running read-buildbot-config step. 05:41:38 INFO - ##### 05:41:38 INFO - Running pre-action listener: _resource_record_pre_action 05:41:38 INFO - Running main action method: read_buildbot_config 05:41:38 INFO - Using buildbot properties: 05:41:38 INFO - { 05:41:38 INFO - "project": "", 05:41:38 INFO - "product": "firefox", 05:41:38 INFO - "script_repo_revision": "production", 05:41:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:41:38 INFO - "repository": "", 05:41:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:41:38 INFO - "buildid": "20160610030239", 05:41:38 INFO - "stage_platform": "linux64-pgo", 05:41:38 INFO - "basedir": "/builds/slave/test", 05:41:38 INFO - "nightly_build": "True", 05:41:38 INFO - "buildnumber": 244, 05:41:38 INFO - "slavename": "talos-linux64-ix-040", 05:41:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:41:38 INFO - "platform": "ubuntu64_hw", 05:41:38 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:41:38 INFO - "branch": "mozilla-central", 05:41:38 INFO - "repo_path": "mozilla-central", 05:41:38 INFO - "revision": "3ccccf8e5036179a3178437cabc154b5e04b333d", 05:41:38 INFO - "pgo_build": "True", 05:41:38 INFO - "builduid": "24c9737725dd49398922c66457171ff8", 05:41:38 INFO - "slavebuilddir": "test" 05:41:38 INFO - } 05:41:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:41:38 INFO - Running post-action listener: _resource_record_post_action 05:41:38 INFO - ##### 05:41:38 INFO - ##### Finished read-buildbot-config step (success) 05:41:38 INFO - ##### 05:41:38 INFO - ##### 05:41:38 INFO - ##### Running download-and-extract step. 05:41:38 INFO - ##### 05:41:38 INFO - Running pre-action listener: _resource_record_pre_action 05:41:38 INFO - Running main action method: download_and_extract 05:41:38 INFO - mkdir: /builds/slave/test/build/tests 05:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:38 INFO - https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:41:38 INFO - Downloaded 1361 bytes. 05:41:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:38 INFO - Using the following test package requirements: 05:41:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:41:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:41:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:38 INFO - u'jsshell-linux-x86_64.zip'], 05:41:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:41:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:41:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:41:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:41:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:41:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:38 INFO - https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:41:51 INFO - Downloaded 24452072 bytes. 05:41:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:41:53 INFO - Return code: 0 05:41:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:53 INFO - https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:41:59 INFO - Downloaded 24452072 bytes. 05:41:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:42:00 INFO - Return code: 0 05:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:00 INFO - https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:42:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:42:01 INFO - Downloaded 10833377 bytes. 05:42:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:42:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:42:01 INFO - Return code: 0 05:42: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')]} 05:42:01 INFO - https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:42:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:42:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:42:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:42:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:42:03 INFO - Downloaded 59329985 bytes. 05:42:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:42:03 INFO - mkdir: /builds/slave/test/properties 05:42:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:42:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:42:03 INFO - Contents: 05:42:03 INFO - build_url:https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:42:03 INFO - Running post-action listener: _resource_record_post_action 05:42:03 INFO - Running post-action listener: set_extra_try_arguments 05:42:03 INFO - ##### 05:42:03 INFO - ##### Finished download-and-extract step (success) 05:42:03 INFO - ##### 05:42:03 INFO - ##### 05:42:03 INFO - ##### Running populate-webroot step. 05:42:03 INFO - ##### 05:42:03 INFO - Running pre-action listener: _resource_record_pre_action 05:42:03 INFO - Running main action method: populate_webroot 05:42:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:42:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:42:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:42:03 INFO - '--tppagecycles', 05:42:03 INFO - '7'], 05:42:03 INFO - 'tests': ['tsvgm']}}, 05:42:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:42:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:42:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:42:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:42:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:42:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:42:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:03 INFO - 'talos_options': ['--disable-e10s'], 05:42:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:03 INFO - 'talos_options': ['--disable-e10s'], 05:42:03 INFO - 'tests': ['damp', 'tps']}, 05:42:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:03 INFO - 'tests': ['damp', 'tps']}, 05:42:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:42:03 INFO - 'tests': ['dromaeo_dom']}, 05:42:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:42:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:42:03 INFO - 'tests': ['a11yr', 05:42:03 INFO - 'ts_paint', 05:42:03 INFO - 'tpaint', 05:42:03 INFO - 'sessionrestore', 05:42:03 INFO - 'sessionrestore_no_auto_restore', 05:42:03 INFO - 'tabpaint']}, 05:42:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:42:03 INFO - 'ts_paint', 05:42:03 INFO - 'tpaint', 05:42:03 INFO - 'sessionrestore', 05:42:03 INFO - 'sessionrestore_no_auto_restore', 05:42:03 INFO - 'tabpaint']}, 05:42:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:42:03 INFO - 'ts_paint', 05:42:03 INFO - 'tpaint', 05:42:03 INFO - 'sessionrestore', 05:42:03 INFO - 'sessionrestore_no_auto_restore', 05:42:03 INFO - 'tabpaint']}, 05:42:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:42:03 INFO - 'ts_paint', 05:42:03 INFO - 'tpaint', 05:42:03 INFO - 'sessionrestore', 05:42:03 INFO - 'sessionrestore_no_auto_restore', 05:42:03 INFO - 'tabpaint']}, 05:42:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:42:03 INFO - 'tests': ['a11yr', 05:42:03 INFO - 'ts_paint', 05:42:03 INFO - 'tpaint', 05:42:03 INFO - 'sessionrestore', 05:42:03 INFO - 'sessionrestore_no_auto_restore', 05:42:03 INFO - 'tabpaint']}, 05:42:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:42:03 INFO - 'tests': ['a11yr', 05:42:03 INFO - 'ts_paint', 05:42:03 INFO - 'tpaint', 05:42:03 INFO - 'sessionrestore', 05:42:03 INFO - 'sessionrestore_no_auto_restore', 05:42:03 INFO - 'tabpaint']}, 05:42:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:42:03 INFO - 'tests': ['tsvgx', 05:42:03 INFO - 'tsvgr_opacity', 05:42:03 INFO - 'tart', 05:42:03 INFO - 'tscrollx', 05:42:03 INFO - 'cart']}, 05:42:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:42:03 INFO - 'tsvgr_opacity', 05:42:03 INFO - 'tart', 05:42:03 INFO - 'tscrollx', 05:42:03 INFO - 'cart']}, 05:42:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:03 INFO - 'talos_options': ['--disable-e10s'], 05:42:03 INFO - 'tests': ['tp5o']}, 05:42:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:03 INFO - 'tests': ['tp5o']}, 05:42:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:03 INFO - 'talos_options': ['--disable-e10s', 05:42:03 INFO - '--xperf_path', 05:42:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:03 INFO - 'tests': ['tp5n']}, 05:42:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:03 INFO - 'talos_options': ['--xperf_path', 05:42:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:03 INFO - 'tests': ['tp5n']}}, 05:42:03 INFO - 'talos.zip': {'path': '', 05:42:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:42:03 INFO - Running post-action listener: _resource_record_post_action 05:42:03 INFO - ##### 05:42:03 INFO - ##### Finished populate-webroot step (success) 05:42:03 INFO - ##### 05:42:03 INFO - ##### 05:42:03 INFO - ##### Running create-virtualenv step. 05:42:03 INFO - ##### 05:42:03 INFO - Running pre-action listener: _resource_record_pre_action 05:42:03 INFO - Running main action method: create_virtualenv 05:42:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:42:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:42:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:42:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:42:04 INFO - Using real prefix '/usr' 05:42:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:42:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:42:06 INFO - Installing pip.................done. 05:42:06 INFO - Return code: 0 05:42:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:06 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 0x7fdc7c879f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:42:06 INFO - Using env: {'DISPLAY': ':0', 05:42:06 INFO - 'HOME': '/home/cltbld', 05:42:06 INFO - 'LANG': 'en_US.UTF-8', 05:42:06 INFO - 'LANGUAGE': 'en_US:en', 05:42:06 INFO - 'LOGNAME': 'cltbld', 05:42:06 INFO - 'MAIL': '/var/mail/cltbld', 05:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:06 INFO - 'MOZ_NO_REMOTE': '1', 05:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:06 INFO - 'NO_EM_RESTART': '1', 05:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:06 INFO - 'PWD': '/builds/slave/test', 05:42:06 INFO - 'SHELL': '/bin/bash', 05:42:06 INFO - 'SHLVL': '1', 05:42:06 INFO - 'TERM': 'linux', 05:42:06 INFO - 'TMOUT': '86400', 05:42:06 INFO - 'USER': 'cltbld', 05:42:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:06 INFO - '_': '/tools/buildbot/bin/python'} 05:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:42:06 INFO - Cleaning up... 05:42:06 INFO - Return code: 0 05:42:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:06 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 0x7fdc7c879f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:06 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 05:42:06 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 05:42:06 INFO - Using env: {'DISPLAY': ':0', 05:42:06 INFO - 'HOME': '/home/cltbld', 05:42:06 INFO - 'LANG': 'en_US.UTF-8', 05:42:06 INFO - 'LANGUAGE': 'en_US:en', 05:42:06 INFO - 'LOGNAME': 'cltbld', 05:42:06 INFO - 'MAIL': '/var/mail/cltbld', 05:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:06 INFO - 'MOZ_NO_REMOTE': '1', 05:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:06 INFO - 'NO_EM_RESTART': '1', 05:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:06 INFO - 'PWD': '/builds/slave/test', 05:42:06 INFO - 'SHELL': '/bin/bash', 05:42:06 INFO - 'SHLVL': '1', 05:42:06 INFO - 'TERM': 'linux', 05:42:06 INFO - 'TMOUT': '86400', 05:42:06 INFO - 'USER': 'cltbld', 05:42:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:06 INFO - '_': '/tools/buildbot/bin/python'} 05:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:06 INFO - Downloading/unpacking psutil>=3.1.1 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:42:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:42:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:42:08 INFO - Installing collected packages: psutil 05:42:08 INFO - Running setup.py install for psutil 05:42:09 INFO - building 'psutil._psutil_linux' extension 05:42:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:42:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:42:09 INFO - building 'psutil._psutil_posix' extension 05:42:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:42:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:42:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:42:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:42:09 INFO - Successfully installed psutil 05:42:09 INFO - Cleaning up... 05:42:09 INFO - Return code: 0 05:42:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:09 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 0x7fdc7c879f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:09 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 05:42:09 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 05:42:09 INFO - Using env: {'DISPLAY': ':0', 05:42:09 INFO - 'HOME': '/home/cltbld', 05:42:09 INFO - 'LANG': 'en_US.UTF-8', 05:42:09 INFO - 'LANGUAGE': 'en_US:en', 05:42:09 INFO - 'LOGNAME': 'cltbld', 05:42:09 INFO - 'MAIL': '/var/mail/cltbld', 05:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:09 INFO - 'MOZ_NO_REMOTE': '1', 05:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:09 INFO - 'NO_EM_RESTART': '1', 05:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:09 INFO - 'PWD': '/builds/slave/test', 05:42:09 INFO - 'SHELL': '/bin/bash', 05:42:09 INFO - 'SHLVL': '1', 05:42:09 INFO - 'TERM': 'linux', 05:42:09 INFO - 'TMOUT': '86400', 05:42:09 INFO - 'USER': 'cltbld', 05:42:09 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:09 INFO - '_': '/tools/buildbot/bin/python'} 05:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:42:11 INFO - Installing collected packages: mozsystemmonitor 05:42:11 INFO - Running setup.py install for mozsystemmonitor 05:42:11 INFO - Successfully installed mozsystemmonitor 05:42:11 INFO - Cleaning up... 05:42:11 INFO - Return code: 0 05:42:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdc7c879f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:42:11 INFO - Using env: {'DISPLAY': ':0', 05:42:11 INFO - 'HOME': '/home/cltbld', 05:42:11 INFO - 'LANG': 'en_US.UTF-8', 05:42:11 INFO - 'LANGUAGE': 'en_US:en', 05:42:11 INFO - 'LOGNAME': 'cltbld', 05:42:11 INFO - 'MAIL': '/var/mail/cltbld', 05:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:11 INFO - 'MOZ_NO_REMOTE': '1', 05:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:11 INFO - 'NO_EM_RESTART': '1', 05:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:11 INFO - 'PWD': '/builds/slave/test', 05:42:11 INFO - 'SHELL': '/bin/bash', 05:42:11 INFO - 'SHLVL': '1', 05:42:11 INFO - 'TERM': 'linux', 05:42:11 INFO - 'TMOUT': '86400', 05:42:11 INFO - 'USER': 'cltbld', 05:42:11 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:11 INFO - '_': '/tools/buildbot/bin/python'} 05:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:12 INFO - Downloading/unpacking jsonschema==2.5.1 05:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:42:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:14 INFO - Downloading functools32-3.2.3-2.tar.gz 05:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:42:14 INFO - warning: no files found matching '*.txt' 05:42:14 INFO - no previously-included directories found matching 'build' 05:42:14 INFO - no previously-included directories found matching 'dist' 05:42:14 INFO - no previously-included directories found matching '.git*' 05:42:14 INFO - Installing collected packages: jsonschema, functools32 05:42:14 INFO - Running setup.py install for functools32 05:42:14 INFO - warning: no files found matching '*.txt' 05:42:14 INFO - no previously-included directories found matching 'build' 05:42:14 INFO - no previously-included directories found matching 'dist' 05:42:14 INFO - no previously-included directories found matching '.git*' 05:42:14 INFO - Successfully installed jsonschema functools32 05:42:14 INFO - Cleaning up... 05:42:14 INFO - Return code: 0 05:42:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:14 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 0x7fdc7c879f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:42:14 INFO - Using env: {'DISPLAY': ':0', 05:42:14 INFO - 'HOME': '/home/cltbld', 05:42:14 INFO - 'LANG': 'en_US.UTF-8', 05:42:14 INFO - 'LANGUAGE': 'en_US:en', 05:42:14 INFO - 'LOGNAME': 'cltbld', 05:42:14 INFO - 'MAIL': '/var/mail/cltbld', 05:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:14 INFO - 'MOZ_NO_REMOTE': '1', 05:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:14 INFO - 'NO_EM_RESTART': '1', 05:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:14 INFO - 'PWD': '/builds/slave/test', 05:42:14 INFO - 'SHELL': '/bin/bash', 05:42:14 INFO - 'SHLVL': '1', 05:42:14 INFO - 'TERM': 'linux', 05:42:14 INFO - 'TMOUT': '86400', 05:42:14 INFO - 'USER': 'cltbld', 05:42:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:14 INFO - '_': '/tools/buildbot/bin/python'} 05:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:42:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:42:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:17 INFO - Downloading docopt-0.6.1.tar.gz 05:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:42:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:42:17 INFO - Running setup.py install for blobuploader 05:42:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:42:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:42:17 INFO - Running setup.py install for requests 05:42:17 INFO - Running setup.py install for docopt 05:42:17 INFO - Successfully installed blobuploader requests docopt 05:42:17 INFO - Cleaning up... 05:42:17 INFO - Return code: 0 05:42:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7c879f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:17 INFO - Using env: {'DISPLAY': ':0', 05:42:17 INFO - 'HOME': '/home/cltbld', 05:42:17 INFO - 'LANG': 'en_US.UTF-8', 05:42:17 INFO - 'LANGUAGE': 'en_US:en', 05:42:17 INFO - 'LOGNAME': 'cltbld', 05:42:17 INFO - 'MAIL': '/var/mail/cltbld', 05:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:17 INFO - 'MOZ_NO_REMOTE': '1', 05:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:17 INFO - 'NO_EM_RESTART': '1', 05:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:17 INFO - 'PWD': '/builds/slave/test', 05:42:17 INFO - 'SHELL': '/bin/bash', 05:42:17 INFO - 'SHLVL': '1', 05:42:17 INFO - 'TERM': 'linux', 05:42:17 INFO - 'TMOUT': '86400', 05:42:17 INFO - 'USER': 'cltbld', 05:42:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:17 INFO - '_': '/tools/buildbot/bin/python'} 05:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:18 INFO - Running setup.py (path:/tmp/pip-YguFE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:18 INFO - Running setup.py (path:/tmp/pip-bJmPFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:18 INFO - Running setup.py (path:/tmp/pip-AVnS1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:18 INFO - Running setup.py (path:/tmp/pip-vB5uI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:18 INFO - Running setup.py (path:/tmp/pip-i6YuSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:18 INFO - Running setup.py (path:/tmp/pip-XL4U7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:18 INFO - Running setup.py (path:/tmp/pip-xmWSlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:18 INFO - Running setup.py (path:/tmp/pip-Bda8R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:18 INFO - Running setup.py (path:/tmp/pip-SJVHjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:18 INFO - Running setup.py (path:/tmp/pip-lGmZBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:18 INFO - Running setup.py (path:/tmp/pip-Q0Kgjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:18 INFO - Running setup.py (path:/tmp/pip-KvUbTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:18 INFO - Running setup.py (path:/tmp/pip-SOimX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:19 INFO - Running setup.py (path:/tmp/pip-XoSxXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:19 INFO - Running setup.py (path:/tmp/pip-IQAHjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:19 INFO - Running setup.py (path:/tmp/pip-go3Lbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:19 INFO - Running setup.py (path:/tmp/pip-N1o209-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:42:19 INFO - Running setup.py install for manifestparser 05:42:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:42:19 INFO - Running setup.py install for mozcrash 05:42:19 INFO - Running setup.py install for mozdebug 05:42:19 INFO - Running setup.py install for mozdevice 05:42:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:42:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:42:19 INFO - Running setup.py install for mozfile 05:42:19 INFO - Running setup.py install for mozhttpd 05:42:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:42:19 INFO - Running setup.py install for mozinfo 05:42:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Running setup.py install for mozInstall 05:42:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Running setup.py install for mozleak 05:42:20 INFO - Running setup.py install for mozlog 05:42:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Running setup.py install for moznetwork 05:42:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Running setup.py install for mozprocess 05:42:20 INFO - Running setup.py install for mozprofile 05:42:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Running setup.py install for mozrunner 05:42:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:42:20 INFO - Running setup.py install for mozscreenshot 05:42:20 INFO - Running setup.py install for moztest 05:42:21 INFO - Running setup.py install for mozversion 05:42:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:42:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:42:21 INFO - Cleaning up... 05:42:21 INFO - Return code: 0 05:42:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:21 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 0x7fdc7c879f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:21 INFO - Using env: {'DISPLAY': ':0', 05:42:21 INFO - 'HOME': '/home/cltbld', 05:42:21 INFO - 'LANG': 'en_US.UTF-8', 05:42:21 INFO - 'LANGUAGE': 'en_US:en', 05:42:21 INFO - 'LOGNAME': 'cltbld', 05:42:21 INFO - 'MAIL': '/var/mail/cltbld', 05:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:21 INFO - 'MOZ_NO_REMOTE': '1', 05:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:21 INFO - 'NO_EM_RESTART': '1', 05:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:21 INFO - 'PWD': '/builds/slave/test', 05:42:21 INFO - 'SHELL': '/bin/bash', 05:42:21 INFO - 'SHLVL': '1', 05:42:21 INFO - 'TERM': 'linux', 05:42:21 INFO - 'TMOUT': '86400', 05:42:21 INFO - 'USER': 'cltbld', 05:42:21 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:21 INFO - '_': '/tools/buildbot/bin/python'} 05:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:21 INFO - Running setup.py (path:/tmp/pip-mBiW4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:21 INFO - Running setup.py (path:/tmp/pip-Y4DIKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:21 INFO - Running setup.py (path:/tmp/pip-qUR8m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:21 INFO - Running setup.py (path:/tmp/pip-L_AGzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:21 INFO - Running setup.py (path:/tmp/pip-kvRskk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:21 INFO - Running setup.py (path:/tmp/pip-vIhpnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:21 INFO - Running setup.py (path:/tmp/pip-90vtOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:21 INFO - Running setup.py (path:/tmp/pip-noYfGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:21 INFO - Running setup.py (path:/tmp/pip-eJdlO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:22 INFO - Running setup.py (path:/tmp/pip-9oJXCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:22 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)) 05:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:22 INFO - Running setup.py (path:/tmp/pip-pB84DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:22 INFO - Running setup.py (path:/tmp/pip-1g65sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:22 INFO - Running setup.py (path:/tmp/pip-guCGY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:22 INFO - Running setup.py (path:/tmp/pip-7HChd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:22 INFO - Running setup.py (path:/tmp/pip-TE2XnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:22 INFO - Running setup.py (path:/tmp/pip-QnIWsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:22 INFO - Running setup.py (path:/tmp/pip-3iszxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:42:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:24 INFO - Downloading blessings-1.6.tar.gz 05:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:42:24 INFO - Installing collected packages: blessings 05:42:24 INFO - Running setup.py install for blessings 05:42:24 INFO - Successfully installed blessings 05:42:24 INFO - Cleaning up... 05:42:24 INFO - Return code: 0 05:42:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:42:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:24 INFO - Reading from file tmpfile_stdout 05:42:24 INFO - Current package versions: 05:42:24 INFO - argparse == 1.2.1 05:42:24 INFO - blessings == 1.6 05:42:24 INFO - blobuploader == 1.2.4 05:42:24 INFO - docopt == 0.6.1 05:42:24 INFO - functools32 == 3.2.3-2 05:42:24 INFO - jsonschema == 2.5.1 05:42:24 INFO - manifestparser == 1.1 05:42:24 INFO - mozInstall == 1.12 05:42:24 INFO - mozcrash == 0.17 05:42:24 INFO - mozdebug == 0.1 05:42:24 INFO - mozdevice == 0.48 05:42:24 INFO - mozfile == 1.2 05:42:24 INFO - mozhttpd == 0.7 05:42:24 INFO - mozinfo == 0.9 05:42:24 INFO - mozleak == 0.1 05:42:24 INFO - mozlog == 3.2 05:42:24 INFO - moznetwork == 0.27 05:42:24 INFO - mozprocess == 0.22 05:42:24 INFO - mozprofile == 0.28 05:42:24 INFO - mozrunner == 6.11 05:42:24 INFO - mozscreenshot == 0.1 05:42:24 INFO - mozsystemmonitor == 0.3 05:42:24 INFO - moztest == 0.7 05:42:24 INFO - mozversion == 1.4 05:42:24 INFO - psutil == 3.1.1 05:42:24 INFO - requests == 1.2.3 05:42:24 INFO - wsgiref == 0.1.2 05:42:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7c879f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:24 INFO - Using env: {'DISPLAY': ':0', 05:42:24 INFO - 'HOME': '/home/cltbld', 05:42:24 INFO - 'LANG': 'en_US.UTF-8', 05:42:24 INFO - 'LANGUAGE': 'en_US:en', 05:42:24 INFO - 'LOGNAME': 'cltbld', 05:42:24 INFO - 'MAIL': '/var/mail/cltbld', 05:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:24 INFO - 'MOZ_NO_REMOTE': '1', 05:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:24 INFO - 'NO_EM_RESTART': '1', 05:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:24 INFO - 'PWD': '/builds/slave/test', 05:42:24 INFO - 'SHELL': '/bin/bash', 05:42:24 INFO - 'SHLVL': '1', 05:42:24 INFO - 'TERM': 'linux', 05:42:24 INFO - 'TMOUT': '86400', 05:42:24 INFO - 'USER': 'cltbld', 05:42:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:24 INFO - '_': '/tools/buildbot/bin/python'} 05:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:42:25 INFO - Cleaning up... 05:42:25 INFO - Return code: 0 05:42:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:25 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 0x7fdc7c879f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:42:25 INFO - Using env: {'DISPLAY': ':0', 05:42:25 INFO - 'HOME': '/home/cltbld', 05:42:25 INFO - 'LANG': 'en_US.UTF-8', 05:42:25 INFO - 'LANGUAGE': 'en_US:en', 05:42:25 INFO - 'LOGNAME': 'cltbld', 05:42:25 INFO - 'MAIL': '/var/mail/cltbld', 05:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:25 INFO - 'MOZ_NO_REMOTE': '1', 05:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:25 INFO - 'NO_EM_RESTART': '1', 05:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:25 INFO - 'PWD': '/builds/slave/test', 05:42:25 INFO - 'SHELL': '/bin/bash', 05:42:25 INFO - 'SHLVL': '1', 05:42:25 INFO - 'TERM': 'linux', 05:42:25 INFO - 'TMOUT': '86400', 05:42:25 INFO - 'USER': 'cltbld', 05:42:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:25 INFO - '_': '/tools/buildbot/bin/python'} 05:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:42:25 INFO - Cleaning up... 05:42:25 INFO - Return code: 0 05:42:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:25 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 0x7fdc7c879f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:42:25 INFO - Using env: {'DISPLAY': ':0', 05:42:25 INFO - 'HOME': '/home/cltbld', 05:42:25 INFO - 'LANG': 'en_US.UTF-8', 05:42:25 INFO - 'LANGUAGE': 'en_US:en', 05:42:25 INFO - 'LOGNAME': 'cltbld', 05:42:25 INFO - 'MAIL': '/var/mail/cltbld', 05:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:25 INFO - 'MOZ_NO_REMOTE': '1', 05:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:25 INFO - 'NO_EM_RESTART': '1', 05:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:25 INFO - 'PWD': '/builds/slave/test', 05:42:25 INFO - 'SHELL': '/bin/bash', 05:42:25 INFO - 'SHLVL': '1', 05:42:25 INFO - 'TERM': 'linux', 05:42:25 INFO - 'TMOUT': '86400', 05:42:25 INFO - 'USER': 'cltbld', 05:42:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:25 INFO - '_': '/tools/buildbot/bin/python'} 05:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:25 INFO - Downloading/unpacking flake8 05:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:42:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:42:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:42:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:28 INFO - no previously-included directories found matching 'docs/_build' 05:42:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:42:28 INFO - Running setup.py install for pep8 05:42:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:28 INFO - no previously-included directories found matching 'docs/_build' 05:42:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:42:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:42:28 INFO - Cleaning up... 05:42:28 INFO - Return code: 0 05:42:28 INFO - Running post-action listener: _resource_record_post_action 05:42:28 INFO - Running post-action listener: _start_resource_monitoring 05:42:28 INFO - Starting resource monitoring. 05:42:28 INFO - ##### 05:42:28 INFO - ##### Finished create-virtualenv step (success) 05:42:28 INFO - ##### 05:42:28 INFO - ##### 05:42:28 INFO - ##### Running install step. 05:42:28 INFO - ##### 05:42:28 INFO - Running pre-action listener: _resource_record_pre_action 05:42:28 INFO - Running main action method: install 05:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:28 INFO - Reading from file tmpfile_stdout 05:42:28 INFO - Detecting whether we're running mozinstall >=1.0... 05:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:42:28 INFO - Reading from file tmpfile_stdout 05:42:28 INFO - Output received: 05:42:28 INFO - Usage: mozinstall [options] installer 05:42:28 INFO - Options: 05:42:28 INFO - -h, --help show this help message and exit 05:42:28 INFO - -d DEST, --destination=DEST 05:42:28 INFO - Directory to install application into. [default: 05:42:28 INFO - "/builds/slave/test"] 05:42:28 INFO - --app=APP Application being installed. [default: firefox] 05:42:28 INFO - mkdir: /builds/slave/test/build/application 05:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:42:45 INFO - Reading from file tmpfile_stdout 05:42:45 INFO - Output received: 05:42:45 INFO - /builds/slave/test/build/application/firefox/firefox 05:42:45 INFO - Running post-action listener: _resource_record_post_action 05:42:45 INFO - ##### 05:42:45 INFO - ##### Finished install step (success) 05:42:45 INFO - ##### 05:42:45 INFO - ##### 05:42:45 INFO - ##### Running run-tests step. 05:42:45 INFO - ##### 05:42:45 INFO - Running pre-action listener: _resource_record_pre_action 05:42:45 INFO - Running main action method: run_tests 05:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:42:45 INFO - Python 2.7.3 05:42:45 INFO - Return code: 0 05:42:45 INFO - grabbing minidump binary from tooltool 05:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:45 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 0x19c51c0>, '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 0x19c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:42:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:42:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:42:45 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 05:42:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:42:45 INFO - Return code: 0 05:42:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:42:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:42:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:42:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:42:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:42:46 INFO - Return code: 0 05:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:42:46 INFO - Using env: {'DISPLAY': ':0', 05:42:46 INFO - 'HOME': '/home/cltbld', 05:42:46 INFO - 'LANG': 'en_US.UTF-8', 05:42:46 INFO - 'LANGUAGE': 'en_US:en', 05:42:46 INFO - 'LOGNAME': 'cltbld', 05:42:46 INFO - 'MAIL': '/var/mail/cltbld', 05:42:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:42:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:46 INFO - 'MOZ_NO_REMOTE': '1', 05:42:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:46 INFO - 'NO_EM_RESTART': '1', 05:42:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:46 INFO - 'PWD': '/builds/slave/test', 05:42:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:42:46 INFO - 'SHELL': '/bin/bash', 05:42:46 INFO - 'SHLVL': '1', 05:42:46 INFO - 'TERM': 'linux', 05:42:46 INFO - 'TMOUT': '86400', 05:42:46 INFO - 'USER': 'cltbld', 05:42:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660', 05:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:46 INFO - '_': '/tools/buildbot/bin/python'} 05:42:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:42:46 INFO - mozversion application_buildid: 20160610030239 05:42:46 INFO - mozversion application_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 05:42:46 INFO - mozversion application_display_name: Nightly 05:42:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:42:46 INFO - mozversion application_name: Firefox 05:42:46 INFO - mozversion application_remotingname: firefox 05:42:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:42:46 INFO - mozversion application_vendor: Mozilla 05:42:46 INFO - mozversion application_version: 50.0a1 05:42:46 INFO - mozversion platform_buildid: 20160610030239 05:42:46 INFO - mozversion platform_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 05:42:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:42:46 INFO - mozversion platform_version: 50.0a1 05:42:46 INFO - using testdate: 1465562566 05:42:46 INFO - actual date: 1465562566 05:42:46 INFO - starting webserver on 'localhost:51559' 05:42:46 INFO - SUITE-START | Running 2 tests 05:42:46 INFO - TEST-START | dromaeo_css 05:42:46 INFO - operating with platform_type : linux_ 05:42:46 INFO - Initialising browser for dromaeo_css test... 05:42:46 INFO - TEST-INFO | started process 3532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOpJjJ/profile http://localhost:51559/getInfo.html) 05:42:51 INFO - PROCESS | 3532 | __metrics Screen width/height:1600/1200 05:42:51 INFO - PROCESS | 3532 | colorDepth:24 05:42:51 INFO - PROCESS | 3532 | Browser inner width/height: 1024/697 05:42:51 INFO - PROCESS | 3532 | __metrics 05:42:52 ERROR - PROCESS | 3532 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:42:53 INFO - TEST-INFO | 3532: exit 0 05:42:53 INFO - Browser initialized. 05:42:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:42:53 INFO - TEST-INFO | started process 3652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOpJjJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:05 INFO - PROCESS | 3652 | RSS: Main: 185266176 05:43:05 INFO - PROCESS | 3652 | 05:43:55 INFO - PROCESS | 3652 | 1465562635114 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:46:03 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:51559/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51559/tests/dromaeo/cssquery-ext.html) 05:46:04 INFO - PROCESS | 3652 | RSS: Main: 187916288 05:46:04 INFO - PROCESS | 3652 | 05:49:06 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:51559/tests/dromaeo/cssquery-ext.html (next: http://localhost:51559/tests/dromaeo/cssquery-jquery.html) 05:49:07 INFO - PROCESS | 3652 | RSS: Main: 187187200 05:49:07 INFO - PROCESS | 3652 | 05:52:09 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:51559/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51559/tests/dromaeo/cssquery-mootools.html) 05:52:09 INFO - PROCESS | 3652 | RSS: Main: 188678144 05:52:09 INFO - PROCESS | 3652 | 05:55:11 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:51559/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51559/tests/dromaeo/cssquery-prototype.html) 05:55:12 INFO - PROCESS | 3652 | RSS: Main: 186028032 05:55:12 INFO - PROCESS | 3652 | 05:58:14 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:51559/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51559/tests/dromaeo/cssquery-yui.html) 05:58:15 INFO - PROCESS | 3652 | RSS: Main: 188166144 05:58:15 INFO - PROCESS | 3652 | 06:01:18 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:51559/tests/dromaeo/cssquery-yui.html (next: http://localhost:51559/tests/dromaeo/cssquery-dojo.html) 06:01:18 INFO - PROCESS | 3652 | RSS: Main: 189493248 06:01:18 INFO - PROCESS | 3652 | 06:01:18 INFO - PROCESS | 3652 | __start_tp_report 06:01:18 INFO - PROCESS | 3652 | _x_x_mozilla_page_load 06:01:18 INFO - PROCESS | 3652 | _x_x_mozilla_page_load_details 06:01:18 INFO - PROCESS | 3652 | |i|pagename|runs| 06:01:18 INFO - PROCESS | 3652 | |0;dojo.html;3130.937381252375;3132.592762940816;3144.606924134483;3147.952780708289;3153.44814657435;5401.513863752261;5467.343918729753;5500.532454741347;5509.861456376939;5538.6399884007615;5370.597205209615;5447.782088716446;5449.863753406167;5508;5549.112142057272;4885.2427873679635;4892.975535122319;4952.083864485082;5068.645194836363;5077.162268225738;4975.577075948549;5091.592672586185;5132.332796736419;5133.896212314352;5139.408967968676;4848.684835485682;4887.997960418105;5010.44885062641;5030.195168772997;5054.064997975368;4862.7325497098;4973;4975.925361119586;4978.427480839678;5008.574271186953;4880.194767863299;4931.630127740434;4944.505549445063;4952.653314268003;4980.526849949249;5399.649022813504;5405.459454054602;5445.891082178334;5479.863003424906;5505.587080968943;5875.794347197828;5876.97061514694;5889.263842019747;5891.734871930774;5899.380565040695;5940.34656187819;5944.524438044989;5944.7027648617395;5958.255218097738;5965.940340596582;5350.197470379435;5469.124940009579;5528.9723551382385;5541.501264886179;5553.8333849984165;5966.880662386728;6009.128676341993;6009.729562169713;6014.067819487899;6046.939530604637;5567.916481252784;5785.739641716049;5789.334226563999;5795.739191736382;5796.5072968797285;5783.479486846204;5803;5829.358770535237;5882.176495290662;5883.764649414061;5684.63049901755;5767.163761254595;5844.795432159854;5852.180694702745;5859.2382990211;5655.264815573949;5785.826425207167;5849.181114643953;5856.765729370777;5871.735771890189;4423.955760442419;4467.709598876063;4470.396496472935;4477.261251893401;4486.842960496432;3999.6600288975183;4002.7398219115667;4007.198560287896;4032.052467670095;4046.8785936421955;5491.28613280271;5531.225628412026;5606.803761868315;5619.943800562024;5621.128725047624;5832.24180856486;5840.941590584125;5844.47399734026;5860.824175274749;5896.852578685567;5600.663960162403;5630.887382252332;5642.4075472075665;5645.971770141123;5650.463205995424;4974.7263900485095;5057.949420505822;5081.212412076134;5103.106956282636;5115.718635475085;6079.513638908877;6096.268447786205;6114.296855861544;6119.44924956756;6137.7851775187655;5904.143899134688;5934.762609495572;5936.168936349001;5938.435848594377;5948.881022379442;5927.14056461802;6060.181875446759;6097.115918191926;6106.096658337741;6190.535709821871;5872.236609240942;5874.970625146847;5879.265091863517;5880.059190529495;5882.176495290748;5717.542596592346;5968.373320801427;5975.940240597538;5976.19321391624;5984.640921544721;5585.245991791056;5610.270664813548;5656.264685590847;5661.915071273852;5666.291713535808;5548.112302031655;5623.522000629992;5683.71581420919;5726.9713651431475;5736.627119237236;5533.612647114664;5576.386597474356;5593.608447408642;5594.104943209067;5595.5523558116065;5645.040343141593;5658.236138121466;5775.220345253505;5777.3933736957015;5820.70896455184;5614.831555053355;5654.802081927113;5657.830265092054;5674.602777805514;5683.090705487102 06:01:18 INFO - PROCESS | 3652 | |1;ext.html;586.3520809505496;622.0762168180253;626.4236902050111;647.9254885688147;651.3519048546696;37942.62057379425;41812;42244.36633450497;42293.36559951603;42427.363589546105;41945.58054419455;42303.57696423035;42441.36337954926;42447;42609.14781704364;8673.609687564074;8830.64677412906;8834;8838.602262898154;8858.689945851896;8766.56167191641;8861.689840855572;8880.911190888073;8881.73354799357;8901.19889209971;8895.33285003624;8938.46369217849;8963.507007114606;8969.820603587925;8975;8883.2893368531;8888.822223555526;8889.199972002518;8901.332400070021;8910.376273660846;8754.080821513713;8831.293496520262;8833.690820821304;8834.514101724402;8874.778130546723;40609;40829;41012;41021;41308.58691413078;2878.3955369372457;3257.364813861298;3279.8196099214533;3292.5719656444508;3466.722662187019;30471.23821904448;30889.691103088906;31026.534601980988;32906.6709332906;34212.657873421194;4363.672724545671;4395.230834603932;4403.735775853459;4428.4243048403505;4525.7284562926;351446;351744;353633;355208.22395888116;356991;34287.65712342845;54369;55537.444625553224;55583.44416555783;55737.44262557403;34973;36812.26375472529;37005.81497092497;37121.44317835235;37129.44305835415;15059.698806023818;15159.924200378928;15233.238338083273;15286;15300.693986120215;12368.876311236772;12418.875811241953;12452.75094498105;12474.313912734886;12485.063620228519;8411.495310281403;8414.36892233085;8477.576121193915;8479.364047696448;8480.406371554056;3233.3694929488993;3248;3254.2189874429964;3284.392387408337;3286.359159963832;997.9700608981742;1007.0332480818496;1021.4994652620163;1052.7999680060916;1101.735583459964;31933.20166995844;32166.517502237486;32484.675153248165;32503.837480812446;32670.183245419055;1085.1969542538466;1086.3590481615884;1091.170710260192;1129.3224065560762;1134.2400591603646;15962.201889905458;16159.43441979525;16193.919030405008;16413.67172656564;16721.498355049367;268119;271231;271895;272025;273728;55937.16094258589;56049;56213.43786562082;56219.718901405235;56243;1383.163186272311;1388.9444422222998;1407.366684991758;1561.2584022589406;1566.5691934718043;28930.132096037152;30930.53604195984;31000.68999309978;31303.84348078245;31434.37131257408;49479.75260123676;49822;49967;50191;50421.74789126031;506397;508606;509234;509316;509697;27434.725652744015;27603.309917251427;27638.72361276442;27829.02598409046;28090.157295281173;46245.30632040589;46382;46514.76742616265;46630.53369466397;47144;39282;39694.60305396909;40092.39861402023;40169.1966160681;40791.94060445419;39714.2057158861;39755.80122099371;39807;40079.1984160321;40406.39390409205;39389.212215756095;39996;40118.197636046534;40133;40152.79923600363;32851.67148328582;35190.648093518736;35587.28825423529;35874.64125358713;36163.81918090393;27045.864770676806;27270.96475922076;27672.308192295353;27790.861045695452;27896.58155127634 06:01:18 INFO - PROCESS | 3652 | |2;jquery.html;378.2477820025349;384.83452115590285;385.19109869274524;397.1953540768367;405.6795131845842;13674.083865756045;15116;17677.204525796336;19252.711209331854;19304.90347548262;17465.476035718948;18008;18194.27154420328;18713.438596842083;18721.531961700963;5526.806561770339;5549.500544950964;5785.681787501686;5787.565932555054;5788.247527821377;5305.681659100466;5679.062954612484;5687.146927960818;5709.514691251248;5715.857103572403;5614.9157762633595;5626.156076588524;5642.633228840133;5672.262605861253;5703.31560212775;5186.974065129669;5435.076037073707;5467.425920278393;5551.99999999996;5625.915611265835;5237.240600112962;5413.891722165574;5417.702026388547;5577.637453565505;5614.185943038277;12316.322602256872;12484.75030499385;12552.560660376843;12617.747645047048;12793.1684440512;2184.213683074092;2204.5039866030015;2334.684817549643;2336.2290444153386;2403.020254883949;9353.579088941015;9395.953020234923;9686.903130968742;9836.95081524595;10126.544305506197;1841.6961201401753;1883.1243471785685;1961.803819618041;1966.8426525878037;2027.6147531969027;72505;77067.22932770601;79186;82911;83636;9990.750231244278;10138.543765530569;10416.635417760343;10629;10676.679699609023;14257.643558910902;14320.928395358165;14378.137311761328;14380.137191768526;14431.927840360731;7684.11632662251;7750.689972401154;7798.376129909594;7815.68737250515;7862.567558784207;7162.820929476805;7284.562926224444;7377.40980721541;7433.070866141732;7468.439867009996;4247.893802654959;4438.1567502174485;4450.154470650566;4587.678862479661;4594.770261486912;1819.8908065515845;1848.432525226326;1860.4790658615339;1867.6078023615194;1896.6111947050822;911.2573252799081;973.3721749471692;1051.5373235776387;1071.5606601293432;1100.1308965916996;18471.261149553866;18795.15421806022;18855.717164242546;18902.243910243436;19255.711164332548;948.2793077261331;952.3428834104445;969.6703120938914;983.498415807943;1059.6767985764416;10303.484825758682;10541.789164216827;10642.132784027943;10679.252452328417;10747.623833165802;446813;458713;476741;481224;486129;77745.6112719444;84082.57958710167;87549;94695.05304947;97429.51285243529;955.0926619711302;990.5592011554933;993.3940296419179;996.940183588987;1007.7581380468781;16686.66626667484;16803;17099.7435038477;17440.302387904343;17600.119994000506;40713;41641.58358416377;41727;42248.36627450529;43497.78251108724;56212.15681764859;58993.395627415324;64408.677956609914;64989;65068.759924499056;8187.672493100209;8536.573171341532;8567.100454452193;8719.782005449915;8885.155910188521;9236.030216827405;11943.641690749291;12571.434285456993;12714.745705086032;12800.295983720986;11304.321740695585;11667.416629168338;11883.287002779862;12086.697832554257;12172.878271217174;10282.485875706334;11155.49800258974;11238.943805280922;11587.710307242387;11606.129540284344;11727.76544469123;11891.702707432383;12163.57427490069;12206.084543659439;12280.87719122833;8066.83866322682;8139.552324621965;8384.30375724843;8398.370122240734;8471.32229421657;11166.218364714392;11540.307581545134;11746.471408786796;11775.23460975034;11888.76222475563 06:01:18 INFO - PROCESS | 3652 | |3;mootools.html;1469.7281003014446;1501.4369611395725;1606.4216881922505;1722.862171026318;1738.313366220343;8227.876581851277;8734.650613975442;8850.734477965656;9438.339316247857;9453.716388508356;8923.063078376757;9113.225375843062;9133.086691330864;9153.862692059625;9259.351845370828;2284.4060544258487;2337.672725818387;2339.836211465198;2341.9648705269433;2344.531093781242;2326.5230627721276;2326.697529321186;2334.6031174700342;2343.60158773009;2353.8823058847074;2266.3654176830514;2281.087564974007;2302.666113413554;2303.3550605830396;2321.8258630602686;2263.6265016272296;2287.874166920819;2290.782375674325;2294.8737819419925;2305.0664480885266;2269.761675024132;2292.736335321426;2301.2060839010514;2306.031466783938;2307.3308740465245;9101.590428430736;9245.491497967609;9259.72220833376;9264.814703705888;9299.48852813095;5253.238280449352;5385.7576409061685;5390.8921821563345;5405.7567409466665;5428.37573679028;3332.266901281714;3450.258194488197;3510.912227194315;3513.6837684608254;3572.9464058039152;1140.361397617337;1202;1218.8354572132826;1223.2415902140729;1234.154604096197;12870.742585148244;12939.67650808728;12979;13040.739185216338;13043.413046412934;4549.226631472658;4661.557152070548;4707.340972263886;4757.785899634525;4772.236442169236;10833.891661083446;10885.074768644596;10889.237753357347;10891.292066015683;10893;5286.7092309922555;5313;5362.436944120811;5372.382176049804;5374.48942350476;4400.933985990213;4829.975850120727;4961.7271050092595;4980.452150263468;4998.90002199954;3905.3556163232747;3925.430812532167;3998.0804414984136;4031.314676505001;4034.91930161401;1222.468226321553;1228.9139760216879;1235.5428491458217;1246.5076294863659;1253.0852477691337;968.3512046928574;983.1446641421866;988.9752756181009;996.342414006752;1015.2791518022287;6282.937170628235;6296.937030629635;6342.23893132827;6373.362663733589;6404.871902562016;1024.1653052761976;1031.8710161229847;1035.60193738454;1042.213129087534;1046.1526163807341;4329.675274354436;4371.672124590668;4374.759388233678;4398.758068306274;4413.3159360299205;10857.239993200557;10932.508037138348;11081.944590276997;11083.556657733761;11230.15773816967;10898.618548350769;11346.886531134747;11350.09199264057;11615.593454229062;11689.883101169049;8403.621837017348;8582.656693732306;8591.226789588967;8606.35452341077;8619;6293.779717709858;6497.610143391412;6505.577137486048;6506.316836732075;6508.186476690414;10375.740606484898;10660.786784264115;10722.571097156026;10806.081483073713;10875.456227188768;10792.892071079188;10811.027007569357;10842.186835987175;10978.176636752436;11010.779784404427;7506.662200201114;7878.5272883624875;8011;8242.835143297221;8343.290820280345;9083.863742044006;9085;9146.451212927246;9157.816843663222;9196.310276729138;7821.491603045783;7999.880001800094;8073.39449541275;8099.757007289791;8155.469894456842;7802.882956755539;7854.096778870503;7872.291493765589;7873.763787086396;8060.717874874351;7372;7416.1471430783995;7416.96291518539;7449.329560339379;7511.624418779148;5318.122509785997;5342;5425.864353391197;5474.5894057945015;5500.889982200413;5372.1941708744;5400.108982017923;5552.7778888845605;5560.777568897361;5562.16567514876 06:01:18 INFO - PROCESS | 3652 | |4;prototype.html;330.28493311979565;330.66437565870643;331.5673046674091;334.4164433064303;338.89833050084985;5543.41794111618;5670.958454956218;5675.51758100562;5676.489115979561;5731.283589551306;5540.448674371182;5582.637128586649;5584.692841893694;5601.187827764971;5604.915926261099;4111.48606424197;4174.22776786294;4279.8502052428175;4288.506821715511;4293.635041021517;4307.1601037797645;4312.929793699011;4315.4389929309145;4336.742344720027;4341.934870976922;4269.188854117723;4295.140971805636;4297.699161058727;4303.935440968388;4318.395424640537;4051.5948405159543;4255.63827074699;4260.510041345223;4269.124829409963;4305.440292761937;3693.261347730465;3710.109573702292;3713.551714831218;3718.2563487302646;3725.795081270529;5434.483724046209;5450.945490545123;5491.450854914517;5493.340799104133;5512.200730894038;4814.253790662453;4892.780432865041;4940.357753492059;4941.777620007072;4966.701997880139;5867.237259156325;5895.496648354642;5896.616719913235;5910.468057874812;5916.745789815627;4069.9389509157386;4098.590140985878;4142.855000074983;4144.626983571493;4153.771542565158;5818.5345172386105;6003.639781613074;6032.45707886288;6039.456448919618;6053.4551890330085;4215.57844215576;4224.683148763855;4229.915401691949;4232.830686772495;4246.681498887596;4226.387173859835;4276.57234276576;4296.785160741951;4297.59172878576;4327.870163895088;4661.021185551072;4949.57928576075;4959;4968.378952630921;4970.72661003641;5819.359870414251;5832.883342333214;5884.617499862496;5956.195913551702;5967.283925928829;1480.7926890235376;1494.46817012563;1495.7307684616874;1497.3486533358025;1497.6779992301708;926.7636752628036;928.5995701112564;959.6161535385762;969.95150242489;995.711243739322;5568.303962004749;5624.71876406178;5669.206311116447;5683.715814209273;5711.343195532484;5985.6408615483215;6028.487578555872;6028.618695615208;6039.184710064085;6043;5507.339119305629;5727.541796656257;5734.942650573441;5777.422257774189;5804.21643078179;3226.3869864725625;3239.5626590409993;3242.492241107896;3257.7556683248376;3258.354530961849;6169.475594574422;6290.4653104485715;6307;6323.873522529524;6347;6178.382161783786;6193.6464143625135;6198.721057552421;6199.938000620026;6244.4380005798785;5965.522758179335;6181.660008699475;6254.437100660963;6265.843353916098;6297.992321228581;6077.149199112217;6077.544184186292;6119.969400153149;6163.876722465615;6175.672230470471;6028.15605815195;6038.969805150946;6057.697115144137;6086.391360863879;6115.541334400027;5895.7052147393315;6310.810675679737;6311.211098612674;6319.304876463493;6347.508335541052;4184.430838435586;4200.243956087934;4203.516595591546;4205.726627769308;4210.852620158403;5823.94176058234;5942.7920022799;6025.66858822769;6097.695115244309;6103.115048318058;5846.35690074083;5855.619384739978;5918.704064796829;5923.644581325134;5927.347991720993;5830.62100963436;5865.946918578464;5873.236479257669;5878;5878.559108066997;5583.994880921473;5706;5759.539236861125;5823.155642431739;5840.678762667924;5858.209141765978;5876.706164691663;5883;5891.263592050994;5896.260603122004;5520.282363292747;5761.769529218785;5783.884322313446;5792.7103644818435;5844.590878638454 06:01:18 INFO - PROCESS | 3652 | |5;yui.html;695.8364784275698;715.3204455767019;774.1407038187614;792.7146227358152;811.3509192645882;16762.91618541907;17181.711371647114;17278;17921.103944802773;18007.81992180078;16454.67090658189;16464.176791160455;16502.42241521547;16559.420420285292;16580.17099145044;652.044754434753;783.7648705388389;810.9472884262534;815.213319147023;816.96732130715;800.671724592917;803.7749430159536;808.3694718119876;810.0522388805083;810.6109067647533;843.6245870587591;845.8858054162671;845.9069502354736;846.1792061700141;849.966001359948;833.72487079264;839.8194388206534;840.0507426607955;842.5534466732641;842.9452085614415;616.9537284703621;618.8947878860605;620.7144713431827;621.6394491195095;622.0327390907138;16045.598860028593;16165.676686466204;16168.434104806276;16226.594335141597;16236.918815405965;15009.549713508612;15029.398824047024;15038.624034399227;15198.848011519964;15377.461788837338;12335.568255111028;12356.320402377865;12366.319852408114;12556.18384804994;12703.491860325576;3830.8276127574327;3853.2871418787336;3943.073377756225;4020.979895100535;4032.858849940238;81637.59181204055;82254.17745822585;82503;83369.16630833675;84122.15877841205;11447.828282575769;11450.94274528622;11672.241304315192;11699.532018719327;12021.639350819489;21608.35174944754;21910.45223869384;21992.78007219939;22060.117595296328;22076.448088797908;8708.956455217683;8742.912570874338;9307.3019523536;9311.06889311077;9320;5034.194528875362;5063.291139240509;5165.535101840853;5204.323437953118;5208.427073021964;3307.520409540603;3363.5291059251726;3366.983165084159;3372.76390652652;3377.3583019226758;644.1014784375864;654.7424183804061;657.789507357641;660.5475249454139;661.5832025823701;692.2039654397483;721.5742711799958;723.4802684937845;737.3142977031413;746.7125156814666;9953.651622193189;10181.134603558781;10220.540075696463;10222.897771022343;10387.584496620051;600.102846244858;644.4103645164715;712.3961919185385;731.1664702239451;732.7435397610793;4698.412698412699;4865.70805751656;4941.950580494221;4952.232403977389;4952.331435256195;110148.44925775481;112923.43538282256;114573;116860.41569792097;117756.41121794336;68415.89504629739;74591;97761;97863.51068244613;100819;86584;86735;86762.56618716866;88618.55690721505;88746.55626721826;8518.914810851813;8633.39566230358;8659.870101948602;8676.305895528469;8777.91222087771;51540.39217254756;52095.739521303665;52584.474155259486;53465;53983.460165397846;63661.68169159124;67020.66489667521;68016.6599167001;68097.65951170212;77226;12741.299228542519;13567.728645427234;13570.253636050113;13638;14168;13396.196228226338;13397;15213.923930380277;15277;15820.525384238492;12756.48974041065;13549.729005420033;13591.320433978064;13618.659533511742;13670.931645342107;13767.931160344135;14459.493917712829;14560.271986400849;14780.778288325899;15053.6989260212;12527.373631318216;12680.936595316964;12726.363681816058;12853.807192892302;13104.737905242033;10035.849462257926;10151.7462063449;10325.173986081245;10620.52207650673;10700.946495267473;11255.268407553483;11551.249168804;11872.703182420508;11884.881151188378;12246.693832654255 06:01:18 INFO - PROCESS | 3652 | __end_tp_report 06:01:18 INFO - PROCESS | 3652 | __start_cc_report 06:01:18 INFO - PROCESS | 3652 | _x_x_mozilla_cycle_collect,339 06:01:18 INFO - PROCESS | 3652 | __end_cc_report 06:01:18 INFO - PROCESS | 3652 | __startTimestamp1465563678583__endTimestamp 06:01:18 INFO - PROCESS | 3652 | 06:01:18 INFO - PROCESS | 3652 | ------- Summary: start ------- 06:01:18 INFO - PROCESS | 3652 | Number of tests: 6 06:01:18 INFO - PROCESS | 3652 | 06:01:18 INFO - PROCESS | 3652 | [#0] dojo.html Cycles:165 Average:5448.48 Median:5630.89 stddev:625.26 (11.1%) stddev-sans-first:600.17 06:01:18 INFO - PROCESS | 3652 | Values: 3130.9 3132.6 3144.6 3148.0 3153.4 5401.5 5467.3 5500.5 5509.9 5538.6 5370.6 5447.8 5449.9 5508.0 5549.1 4885.2 4893.0 4952.1 5068.6 5077.2 4975.6 5091.6 5132.3 5133.9 5139.4 4848.7 4888.0 5010.4 5030.2 5054.1 4862.7 4973.0 4975.9 4978.4 5008.6 4880.2 4931.6 4944.5 4952.7 4980.5 5399.6 5405.5 5445.9 5479.9 5505.6 5875.8 5877.0 5889.3 5891.7 5899.4 5940.3 5944.5 5944.7 5958.3 5965.9 5350.2 5469.1 5529.0 5541.5 5553.8 5966.9 6009.1 6009.7 6014.1 6046.9 5567.9 5785.7 5789.3 5795.7 5796.5 5783.5 5803.0 5829.4 5882.2 5883.8 5684.6 5767.2 5844.8 5852.2 5859.2 5655.3 5785.8 5849.2 5856.8 5871.7 4424.0 4467.7 4470.4 4477.3 4486.8 3999.7 4002.7 4007.2 4032.1 4046.9 5491.3 5531.2 5606.8 5619.9 5621.1 5832.2 5840.9 5844.5 5860.8 5896.9 5600.7 5630.9 5642.4 5646.0 5650.5 4974.7 5057.9 5081.2 5103.1 5115.7 6079.5 6096.3 6114.3 6119.4 6137.8 5904.1 5934.8 5936.2 5938.4 5948.9 5927.1 6060.2 6097.1 6106.1 6190.5 5872.2 5875.0 5879.3 5880.1 5882.2 5717.5 5968.4 5975.9 5976.2 5984.6 5585.2 5610.3 5656.3 5661.9 5666.3 5548.1 5623.5 5683.7 5727.0 5736.6 5533.6 5576.4 5593.6 5594.1 5595.6 5645.0 5658.2 5775.2 5777.4 5820.7 5614.8 5654.8 5657.8 5674.6 5683.1 06:01:18 INFO - PROCESS | 3652 | 06:01:18 INFO - PROCESS | 3652 | [#1] ext.html Cycles:180 Average:53223.85 Median:39781.40 stddev:103613.93 (260.5%) stddev-sans-first:103829.22 06:01:18 INFO - PROCESS | 3652 | Values: 586.4 622.1 626.4 647.9 651.4 37942.6 41812.0 42244.4 42293.4 42427.4 41945.6 42303.6 42441.4 42447.0 42609.1 8673.6 8830.6 8834.0 8838.6 8858.7 8766.6 8861.7 8880.9 8881.7 8901.2 8895.3 8938.5 8963.5 8969.8 8975.0 8883.3 8888.8 8889.2 8901.3 8910.4 8754.1 8831.3 8833.7 8834.5 8874.8 40609.0 40829.0 41012.0 41021.0 41308.6 2878.4 3257.4 3279.8 3292.6 3466.7 30471.2 30889.7 31026.5 32906.7 34212.7 4363.7 4395.2 4403.7 4428.4 4525.7 351446.0 351744.0 353633.0 355208.2 356991.0 34287.7 54369.0 55537.4 55583.4 55737.4 34973.0 36812.3 37005.8 37121.4 37129.4 15059.7 15159.9 15233.2 15286.0 15300.7 12368.9 12418.9 12452.8 12474.3 12485.1 8411.5 8414.4 8477.6 8479.4 8480.4 3233.4 3248.0 3254.2 3284.4 3286.4 998.0 1007.0 1021.5 1052.8 1101.7 31933.2 32166.5 32484.7 32503.8 32670.2 1085.2 1086.4 1091.2 1129.3 1134.2 15962.2 16159.4 16193.9 16413.7 16721.5 268119.0 271231.0 271895.0 272025.0 273728.0 55937.2 56049.0 56213.4 56219.7 56243.0 1383.2 1388.9 1407.4 1561.3 1566.6 28930.1 30930.5 31000.7 31303.8 31434.4 49479.8 49822.0 49967.0 50191.0 50421.7 506397.0 508606.0 509234.0 509316.0 509697.0 27434.7 27603.3 27638.7 27829.0 28090.2 46245.3 46382.0 46514.8 46630.5 47144.0 39282.0 39694.6 40092.4 40169.2 40791.9 39714.2 39755.8 39807.0 40079.2 40406.4 39389.2 39996.0 40118.2 40133.0 40152.8 32851.7 35190.6 35587.3 35874.6 36163.8 27045.9 27271.0 27672.3 27790.9 27896.6 06:01:18 INFO - PROCESS | 3652 | 06:01:18 INFO - PROCESS | 3652 | [#2] jquery.html Cycles:180 Average:27840.50 Median:41684.29 stddev:77668.34 (186.3%) stddev-sans-first:77858.85 06:01:18 INFO - PROCESS | 3652 | Values: 378.2 384.8 385.2 397.2 405.7 13674.1 15116.0 17677.2 19252.7 19304.9 17465.5 18008.0 18194.3 18713.4 18721.5 5526.8 5549.5 5785.7 5787.6 5788.2 5305.7 5679.1 5687.1 5709.5 5715.9 5614.9 5626.2 5642.6 5672.3 5703.3 5187.0 5435.1 5467.4 5552.0 5625.9 5237.2 5413.9 5417.7 5577.6 5614.2 12316.3 12484.8 12552.6 12617.7 12793.2 2184.2 2204.5 2334.7 2336.2 2403.0 9353.6 9396.0 9686.9 9837.0 10126.5 1841.7 1883.1 1961.8 1966.8 2027.6 72505.0 77067.2 79186.0 82911.0 83636.0 9990.8 10138.5 10416.6 10629.0 10676.7 14257.6 14320.9 14378.1 14380.1 14431.9 7684.1 7750.7 7798.4 7815.7 7862.6 7162.8 7284.6 7377.4 7433.1 7468.4 4247.9 4438.2 4450.2 4587.7 4594.8 1819.9 1848.4 1860.5 1867.6 1896.6 911.3 973.4 1051.5 1071.6 1100.1 18471.3 18795.2 18855.7 18902.2 19255.7 948.3 952.3 969.7 983.5 1059.7 10303.5 10541.8 10642.1 10679.3 10747.6 446813.0 458713.0 476741.0 481224.0 486129.0 77745.6 84082.6 87549.0 94695.1 97429.5 955.1 990.6 993.4 996.9 1007.8 16686.7 16803.0 17099.7 17440.3 17600.1 40713.0 41641.6 41727.0 42248.4 43497.8 56212.2 58993.4 64408.7 64989.0 65068.8 8187.7 8536.6 8567.1 8719.8 8885.2 9236.0 11943.6 12571.4 12714.7 12800.3 11304.3 11667.4 11883.3 12086.7 12172.9 10282.5 11155.5 11238.9 11587.7 11606.1 11727.8 11891.7 12163.6 12206.1 12280.9 8066.8 8139.6 8384.3 8398.4 8471.3 11166.2 11540.3 11746.5 11775.2 11888.8 06:01:18 INFO - PROCESS | 3652 | 06:01:18 INFO - PROCESS | 3652 | [#3] mootools.html Cycles:180 Average:6043.91 Median:4407.12 stddev:3477.19 (78.9%) stddev-sans-first:3469.95 06:01:18 INFO - PROCESS | 3652 | Values: 1469.7 1501.4 1606.4 1722.9 1738.3 8227.9 8734.7 8850.7 9438.3 9453.7 8923.1 9113.2 9133.1 9153.9 9259.4 2284.4 2337.7 2339.8 2342.0 2344.5 2326.5 2326.7 2334.6 2343.6 2353.9 2266.4 2281.1 2302.7 2303.4 2321.8 2263.6 2287.9 2290.8 2294.9 2305.1 2269.8 2292.7 2301.2 2306.0 2307.3 9101.6 9245.5 9259.7 9264.8 9299.5 5253.2 5385.8 5390.9 5405.8 5428.4 3332.3 3450.3 3510.9 3513.7 3572.9 1140.4 1202.0 1218.8 1223.2 1234.2 12870.7 12939.7 12979.0 13040.7 13043.4 4549.2 4661.6 4707.3 4757.8 4772.2 10833.9 10885.1 10889.2 10891.3 10893.0 5286.7 5313.0 5362.4 5372.4 5374.5 4400.9 4830.0 4961.7 4980.5 4998.9 3905.4 3925.4 3998.1 4031.3 4034.9 1222.5 1228.9 1235.5 1246.5 1253.1 968.4 983.1 989.0 996.3 1015.3 6282.9 6296.9 6342.2 6373.4 6404.9 1024.2 1031.9 1035.6 1042.2 1046.2 4329.7 4371.7 4374.8 4398.8 4413.3 10857.2 10932.5 11081.9 11083.6 11230.2 10898.6 11346.9 11350.1 11615.6 11689.9 8403.6 8582.7 8591.2 8606.4 8619.0 6293.8 6497.6 6505.6 6506.3 6508.2 10375.7 10660.8 10722.6 10806.1 10875.5 10792.9 10811.0 10842.2 10978.2 11010.8 7506.7 7878.5 8011.0 8242.8 8343.3 9083.9 9085.0 9146.5 9157.8 9196.3 7821.5 7999.9 8073.4 8099.8 8155.5 7802.9 7854.1 7872.3 7873.8 8060.7 7372.0 7416.1 7417.0 7449.3 7511.6 5318.1 5342.0 5425.9 5474.6 5500.9 5372.2 5400.1 5552.8 5560.8 5562.2 06:01:18 INFO - PROCESS | 3652 | 06:01:18 INFO - PROCESS | 3652 | [#4] prototype.html Cycles:180 Average:4932.89 Median:5694.86 stddev:1478.60 (26.0%) stddev-sans-first:1441.82 06:01:18 INFO - PROCESS | 3652 | Values: 330.3 330.7 331.6 334.4 338.9 5543.4 5671.0 5675.5 5676.5 5731.3 5540.4 5582.6 5584.7 5601.2 5604.9 4111.5 4174.2 4279.9 4288.5 4293.6 4307.2 4312.9 4315.4 4336.7 4341.9 4269.2 4295.1 4297.7 4303.9 4318.4 4051.6 4255.6 4260.5 4269.1 4305.4 3693.3 3710.1 3713.6 3718.3 3725.8 5434.5 5450.9 5491.5 5493.3 5512.2 4814.3 4892.8 4940.4 4941.8 4966.7 5867.2 5895.5 5896.6 5910.5 5916.7 4069.9 4098.6 4142.9 4144.6 4153.8 5818.5 6003.6 6032.5 6039.5 6053.5 4215.6 4224.7 4229.9 4232.8 4246.7 4226.4 4276.6 4296.8 4297.6 4327.9 4661.0 4949.6 4959.0 4968.4 4970.7 5819.4 5832.9 5884.6 5956.2 5967.3 1480.8 1494.5 1495.7 1497.3 1497.7 926.8 928.6 959.6 970.0 995.7 5568.3 5624.7 5669.2 5683.7 5711.3 5985.6 6028.5 6028.6 6039.2 6043.0 5507.3 5727.5 5734.9 5777.4 5804.2 3226.4 3239.6 3242.5 3257.8 3258.4 6169.5 6290.5 6307.0 6323.9 6347.0 6178.4 6193.6 6198.7 6199.9 6244.4 5965.5 6181.7 6254.4 6265.8 6298.0 6077.1 6077.5 6120.0 6163.9 6175.7 6028.2 6039.0 6057.7 6086.4 6115.5 5895.7 6310.8 6311.2 6319.3 6347.5 4184.4 4200.2 4203.5 4205.7 4210.9 5823.9 5942.8 6025.7 6097.7 6103.1 5846.4 5855.6 5918.7 5923.6 5927.3 5830.6 5865.9 5873.2 5878.0 5878.6 5584.0 5706.0 5759.5 5823.2 5840.7 5858.2 5876.7 5883.0 5891.3 5896.3 5520.3 5761.8 5783.9 5792.7 5844.6 06:01:18 INFO - PROCESS | 3652 | 06:01:18 INFO - PROCESS | 3652 | [#5] yui.html Cycles:180 Average:20789.30 Median:4782.06 stddev:29370.91 (614.2%) stddev-sans-first:29414.55 06:01:18 INFO - PROCESS | 3652 | Values: 695.8 715.3 774.1 792.7 811.4 16762.9 17181.7 17278.0 17921.1 18007.8 16454.7 16464.2 16502.4 16559.4 16580.2 652.0 783.8 810.9 815.2 817.0 800.7 803.8 808.4 810.1 810.6 843.6 845.9 845.9 846.2 850.0 833.7 839.8 840.1 842.6 842.9 617.0 618.9 620.7 621.6 622.0 16045.6 16165.7 16168.4 16226.6 16236.9 15009.5 15029.4 15038.6 15198.8 15377.5 12335.6 12356.3 12366.3 12556.2 12703.5 3830.8 3853.3 3943.1 4021.0 4032.9 81637.6 82254.2 82503.0 83369.2 84122.2 11447.8 11450.9 11672.2 11699.5 12021.6 21608.4 21910.5 21992.8 22060.1 22076.4 8709.0 8742.9 9307.3 9311.1 9320.0 5034.2 5063.3 5165.5 5204.3 5208.4 3307.5 3363.5 3367.0 3372.8 3377.4 644.1 654.7 657.8 660.5 661.6 692.2 721.6 723.5 737.3 746.7 9953.7 10181.1 10220.5 10222.9 10387.6 600.1 644.4 712.4 731.2 732.7 4698.4 4865.7 4942.0 4952.2 4952.3 110148.4 112923.4 114573.0 116860.4 117756.4 68415.9 74591.0 97761.0 97863.5 100819.0 86584.0 86735.0 86762.6 88618.6 88746.6 8518.9 8633.4 8659.9 8676.3 8777.9 51540.4 52095.7 52584.5 53465.0 53983.5 63661.7 67020.7 68016.7 68097.7 77226.0 12741.3 13567.7 13570.3 13638.0 14168.0 13396.2 13397.0 15213.9 15277.0 15820.5 12756.5 13549.7 13591.3 13618.7 13670.9 13767.9 14459.5 14560.3 14780.8 15053.7 12527.4 12680.9 12726.4 12853.8 13104.7 10035.8 10151.7 10325.2 10620.5 10700.9 11255.3 11551.2 11872.7 11884.9 12246.7 06:01:18 INFO - PROCESS | 3652 | -------- Summary: end -------- 06:01:18 INFO - PROCESS | 3652 | 06:01:19 INFO - TEST-INFO | 3652: exit 0 06:01:19 INFO - TEST-OK | dromaeo_css | took 1112573ms 06:01:19 INFO - TEST-START | kraken 06:01:19 INFO - operating with platform_type : linux_ 06:01:19 INFO - Initialising browser for kraken test... 06:01:19 INFO - TEST-INFO | started process 3888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPGHmId/profile http://localhost:51559/getInfo.html) 06:01:24 INFO - PROCESS | 3888 | __metrics Screen width/height:1600/1200 06:01:24 INFO - PROCESS | 3888 | colorDepth:24 06:01:24 INFO - PROCESS | 3888 | Browser inner width/height: 1024/697 06:01:24 INFO - PROCESS | 3888 | __metrics 06:01:24 ERROR - PROCESS | 3888 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:01:25 INFO - TEST-INFO | 3888: exit 0 06:01:25 INFO - Browser initialized. 06:01:25 INFO - Running cycle 1/1 for kraken test... 06:01:25 INFO - TEST-INFO | started process 4011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPGHmId/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:37 INFO - PROCESS | 4011 | RSS: Main: 184885248 06:01:37 INFO - PROCESS | 4011 | 06:01:40 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51559/tests/kraken/driver.html?testName=audio-beat-detection) 06:01:40 INFO - PROCESS | 4011 | RSS: Main: 190234624 06:01:40 INFO - PROCESS | 4011 | 06:01:43 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51559/tests/kraken/driver.html?testName=audio-dft) 06:01:44 INFO - PROCESS | 4011 | RSS: Main: 189321216 06:01:44 INFO - PROCESS | 4011 | 06:01:47 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51559/tests/kraken/driver.html?testName=audio-fft) 06:01:47 INFO - PROCESS | 4011 | RSS: Main: 183984128 06:01:47 INFO - PROCESS | 4011 | 06:01:50 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51559/tests/kraken/driver.html?testName=audio-oscillator) 06:01:50 INFO - PROCESS | 4011 | RSS: Main: 185057280 06:01:50 INFO - PROCESS | 4011 | 06:01:52 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51559/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:01:53 INFO - PROCESS | 4011 | RSS: Main: 185131008 06:01:53 INFO - PROCESS | 4011 | 06:01:56 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51559/tests/kraken/driver.html?testName=imaging-darkroom) 06:01:57 INFO - PROCESS | 4011 | RSS: Main: 185913344 06:01:57 INFO - PROCESS | 4011 | 06:02:00 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51559/tests/kraken/driver.html?testName=imaging-desaturate) 06:02:01 INFO - PROCESS | 4011 | RSS: Main: 183083008 06:02:01 INFO - PROCESS | 4011 | 06:02:04 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51559/tests/kraken/driver.html?testName=json-parse-financial) 06:02:04 INFO - PROCESS | 4011 | RSS: Main: 184393728 06:02:04 INFO - PROCESS | 4011 | 06:02:06 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51559/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:02:07 INFO - PROCESS | 4011 | RSS: Main: 184938496 06:02:07 INFO - PROCESS | 4011 | 06:02:08 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51559/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:02:09 INFO - PROCESS | 4011 | RSS: Main: 185479168 06:02:09 INFO - PROCESS | 4011 | 06:02:11 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51559/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:02:12 INFO - PROCESS | 4011 | RSS: Main: 185425920 06:02:12 INFO - PROCESS | 4011 | 06:02:14 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:02:15 INFO - PROCESS | 4011 | RSS: Main: 185442304 06:02:15 INFO - PROCESS | 4011 | 06:02:18 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:02:18 INFO - PROCESS | 4011 | RSS: Main: 185323520 06:02:18 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | Cycle 1(1): loaded http://localhost:51559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51559/tests/kraken/driver.html?testName=ai-astar) 06:02:20 INFO - PROCESS | 4011 | RSS: Main: 186122240 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | __start_tp_report 06:02:20 INFO - PROCESS | 4011 | _x_x_mozilla_page_load 06:02:20 INFO - PROCESS | 4011 | _x_x_mozilla_page_load_details 06:02:20 INFO - PROCESS | 4011 | |i|pagename|runs| 06:02:20 INFO - PROCESS | 4011 | |0;ai-astar;111;106;111;110;112;113;112;110;110;110 06:02:20 INFO - PROCESS | 4011 | |1;audio-beat-detection;156;124;151;186;141;159;155;130;203;126 06:02:20 INFO - PROCESS | 4011 | |2;audio-dft;163;163;163;162;164;171;163;163;164;164 06:02:20 INFO - PROCESS | 4011 | |3;audio-fft;76;78;77;155;77;76;77;76;158;79 06:02:20 INFO - PROCESS | 4011 | |4;audio-oscillator;85;85;140;86;85;85;149;86;85;140 06:02:20 INFO - PROCESS | 4011 | |5;imaging-gaussian-blur;118;118;118;117;119;118;118;118;117;118 06:02:20 INFO - PROCESS | 4011 | |6;imaging-darkroom;148;147;148;149;147;148;148;147;147;148 06:02:20 INFO - PROCESS | 4011 | |7;imaging-desaturate;95;95;95;95;96;96;100;97;96;96 06:02:20 INFO - PROCESS | 4011 | |8;json-parse-financial;57;55;61;55;55;56;54;59;55;56 06:02:20 INFO - PROCESS | 4011 | |9;json-stringify-tinderbox;62;63;61;62;63;62;62;62;62;63 06:02:20 INFO - PROCESS | 4011 | |10;stanford-crypto-aes;80;82;81;80;81;86;81;81;109;87 06:02:20 INFO - PROCESS | 4011 | |11;stanford-crypto-ccm;125;125;131;130;124;125;132;133;136;134 06:02:20 INFO - PROCESS | 4011 | |12;stanford-crypto-pbkdf2;162;165;160;158;160;160;166;160;161;162 06:02:20 INFO - PROCESS | 4011 | |13;stanford-crypto-sha256-iterative;66;64;66;65;62;65;62;63;63;63 06:02:20 INFO - PROCESS | 4011 | __end_tp_report 06:02:20 INFO - PROCESS | 4011 | __start_cc_report 06:02:20 INFO - PROCESS | 4011 | _x_x_mozilla_cycle_collect,853 06:02:20 INFO - PROCESS | 4011 | __end_cc_report 06:02:20 INFO - PROCESS | 4011 | __startTimestamp1465563740658__endTimestamp 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | ------- Summary: start ------- 06:02:20 INFO - PROCESS | 4011 | Number of tests: 14 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.90 (1.7%) stddev-sans-first:2.01 06:02:20 INFO - PROCESS | 4011 | Values: 111.0 106.0 111.0 110.0 112.0 113.0 112.0 110.0 110.0 110.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:155.50 stddev:25.57 (16.4%) stddev-sans-first:27.10 06:02:20 INFO - PROCESS | 4011 | Values: 156.0 124.0 151.0 186.0 141.0 159.0 155.0 130.0 203.0 126.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.54 (1.6%) stddev-sans-first:2.67 06:02:20 INFO - PROCESS | 4011 | Values: 163.0 163.0 163.0 162.0 164.0 171.0 163.0 163.0 164.0 164.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#3] audio-fft Cycles:10 Average:92.90 Median:77.00 stddev:33.54 (43.6%) stddev-sans-first:35.01 06:02:20 INFO - PROCESS | 4011 | Values: 76.0 78.0 77.0 155.0 77.0 76.0 77.0 76.0 158.0 79.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:85.00 stddev:27.99 (32.9%) stddev-sans-first:28.95 06:02:20 INFO - PROCESS | 4011 | Values: 85.0 85.0 140.0 86.0 85.0 85.0 149.0 86.0 85.0 140.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:02:20 INFO - PROCESS | 4011 | Values: 118.0 118.0 118.0 117.0 119.0 118.0 118.0 118.0 117.0 118.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:02:20 INFO - PROCESS | 4011 | Values: 148.0 147.0 148.0 149.0 147.0 148.0 148.0 147.0 147.0 148.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.52 (1.6%) stddev-sans-first:1.56 06:02:20 INFO - PROCESS | 4011 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 100.0 97.0 96.0 96.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:2.16 (3.9%) stddev-sans-first:2.28 06:02:20 INFO - PROCESS | 4011 | Values: 57.0 55.0 61.0 55.0 55.0 56.0 54.0 59.0 55.0 56.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 06:02:20 INFO - PROCESS | 4011 | Values: 62.0 63.0 61.0 62.0 63.0 62.0 62.0 62.0 62.0 63.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:81.00 stddev:8.84 (10.9%) stddev-sans-first:9.21 06:02:20 INFO - PROCESS | 4011 | Values: 80.0 82.0 81.0 80.0 81.0 86.0 81.0 81.0 109.0 87.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:131.50 stddev:4.40 (3.3%) stddev-sans-first:4.36 06:02:20 INFO - PROCESS | 4011 | Values: 125.0 125.0 131.0 130.0 124.0 125.0 132.0 133.0 136.0 134.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.50 stddev:2.46 (1.5%) stddev-sans-first:2.60 06:02:20 INFO - PROCESS | 4011 | Values: 162.0 165.0 160.0 158.0 160.0 160.0 166.0 160.0 161.0 162.0 06:02:20 INFO - PROCESS | 4011 | 06:02:20 INFO - PROCESS | 4011 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.52 (2.4%) stddev-sans-first:1.41 06:02:20 INFO - PROCESS | 4011 | Values: 66.0 64.0 66.0 65.0 62.0 65.0 62.0 63.0 63.0 63.0 06:02:20 INFO - PROCESS | 4011 | -------- Summary: end -------- 06:02:20 INFO - PROCESS | 4011 | 06:02:21 INFO - TEST-INFO | 4011: exit 0 06:02:21 INFO - TEST-OK | kraken | took 62301ms 06:02:21 INFO - SUITE-END | took 1174s 06:02:21 INFO - Completed test suite (00:19:35) 06:02:21 INFO - javascript benchmark 06:02:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7237.18681145915, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.937381252375, 3132.592762940816, 3144.606924134483, 3147.952780708289, 3153.44814657435, 5401.513863752261, 5467.343918729753, 5500.532454741347, 5509.861456376939, 5538.6399884007615, 5370.597205209615, 5447.782088716446, 5449.863753406167, 5508.0, 5549.112142057272, 4885.2427873679635, 4892.975535122319, 4952.083864485082, 5068.645194836363, 5077.162268225738, 4975.577075948549, 5091.592672586185, 5132.332796736419, 5133.896212314352, 5139.408967968676, 4848.684835485682, 4887.997960418105, 5010.44885062641, 5030.195168772997, 5054.064997975368, 4862.7325497098, 4973.0, 4975.925361119586, 4978.427480839678, 5008.574271186953, 4880.194767863299, 4931.630127740434, 4944.505549445063, 4952.653314268003, 4980.526849949249, 5399.649022813504, 5405.459454054602, 5445.891082178334, 5479.863003424906, 5505.587080968943, 5875.794347197828, 5876.97061514694, 5889.263842019747, 5891.734871930774, 5899.380565040695, 5940.34656187819, 5944.524438044989, 5944.7027648617395, 5958.255218097738, 5965.940340596582, 5350.197470379435, 5469.124940009579, 5528.9723551382385, 5541.501264886179, 5553.8333849984165, 5966.880662386728, 6009.128676341993, 6009.729562169713, 6014.067819487899, 6046.939530604637, 5567.916481252784, 5785.739641716049, 5789.334226563999, 5795.739191736382, 5796.5072968797285, 5783.479486846204, 5803.0, 5829.358770535237, 5882.176495290662, 5883.764649414061, 5684.63049901755, 5767.163761254595, 5844.795432159854, 5852.180694702745, 5859.2382990211, 5655.264815573949, 5785.826425207167, 5849.181114643953, 5856.765729370777, 5871.735771890189, 4423.955760442419, 4467.709598876063, 4470.396496472935, 4477.261251893401, 4486.842960496432, 3999.6600288975183, 4002.7398219115667, 4007.198560287896, 4032.052467670095, 4046.8785936421955, 5491.28613280271, 5531.225628412026, 5606.803761868315, 5619.943800562024, 5621.128725047624, 5832.24180856486, 5840.941590584125, 5844.47399734026, 5860.824175274749, 5896.852578685567, 5600.663960162403, 5630.887382252332, 5642.4075472075665, 5645.971770141123, 5650.463205995424, 4974.7263900485095, 5057.949420505822, 5081.212412076134, 5103.106956282636, 5115.718635475085, 6079.513638908877, 6096.268447786205, 6114.296855861544, 6119.44924956756, 6137.7851775187655, 5904.143899134688, 5934.762609495572, 5936.168936349001, 5938.435848594377, 5948.881022379442, 5927.14056461802, 6060.181875446759, 6097.115918191926, 6106.096658337741, 6190.535709821871, 5872.236609240942, 5874.970625146847, 5879.265091863517, 5880.059190529495, 5882.176495290748, 5717.542596592346, 5968.373320801427, 5975.940240597538, 5976.19321391624, 5984.640921544721, 5585.245991791056, 5610.270664813548, 5656.264685590847, 5661.915071273852, 5666.291713535808, 5548.112302031655, 5623.522000629992, 5683.71581420919, 5726.9713651431475, 5736.627119237236, 5533.612647114664, 5576.386597474356, 5593.608447408642, 5594.104943209067, 5595.5523558116065, 5645.040343141593, 5658.236138121466, 5775.220345253505, 5777.3933736957015, 5820.70896455184, 5614.831555053355, 5654.802081927113, 5657.830265092054, 5674.602777805514, 5683.090705487102], "value": 5405.7114739270855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.3520809505496, 622.0762168180253, 626.4236902050111, 647.9254885688147, 651.3519048546696, 37942.62057379425, 41812.0, 42244.36633450497, 42293.36559951603, 42427.363589546105, 41945.58054419455, 42303.57696423035, 42441.36337954926, 42447.0, 42609.14781704364, 8673.609687564074, 8830.64677412906, 8834.0, 8838.602262898154, 8858.689945851896, 8766.56167191641, 8861.689840855572, 8880.911190888073, 8881.73354799357, 8901.19889209971, 8895.33285003624, 8938.46369217849, 8963.507007114606, 8969.820603587925, 8975.0, 8883.2893368531, 8888.822223555526, 8889.199972002518, 8901.332400070021, 8910.376273660846, 8754.080821513713, 8831.293496520262, 8833.690820821304, 8834.514101724402, 8874.778130546723, 40609.0, 40829.0, 41012.0, 41021.0, 41308.58691413078, 2878.3955369372457, 3257.364813861298, 3279.8196099214533, 3292.5719656444508, 3466.722662187019, 30471.23821904448, 30889.691103088906, 31026.534601980988, 32906.6709332906, 34212.657873421194, 4363.672724545671, 4395.230834603932, 4403.735775853459, 4428.4243048403505, 4525.7284562926, 351446.0, 351744.0, 353633.0, 355208.22395888116, 356991.0, 34287.65712342845, 54369.0, 55537.444625553224, 55583.44416555783, 55737.44262557403, 34973.0, 36812.26375472529, 37005.81497092497, 37121.44317835235, 37129.44305835415, 15059.698806023818, 15159.924200378928, 15233.238338083273, 15286.0, 15300.693986120215, 12368.876311236772, 12418.875811241953, 12452.75094498105, 12474.313912734886, 12485.063620228519, 8411.495310281403, 8414.36892233085, 8477.576121193915, 8479.364047696448, 8480.406371554056, 3233.3694929488993, 3248.0, 3254.2189874429964, 3284.392387408337, 3286.359159963832, 997.9700608981742, 1007.0332480818496, 1021.4994652620163, 1052.7999680060916, 1101.735583459964, 31933.20166995844, 32166.517502237486, 32484.675153248165, 32503.837480812446, 32670.183245419055, 1085.1969542538466, 1086.3590481615884, 1091.170710260192, 1129.3224065560762, 1134.2400591603646, 15962.201889905458, 16159.43441979525, 16193.919030405008, 16413.67172656564, 16721.498355049367, 268119.0, 271231.0, 271895.0, 272025.0, 273728.0, 55937.16094258589, 56049.0, 56213.43786562082, 56219.718901405235, 56243.0, 1383.163186272311, 1388.9444422222998, 1407.366684991758, 1561.2584022589406, 1566.5691934718043, 28930.132096037152, 30930.53604195984, 31000.68999309978, 31303.84348078245, 31434.37131257408, 49479.75260123676, 49822.0, 49967.0, 50191.0, 50421.74789126031, 506397.0, 508606.0, 509234.0, 509316.0, 509697.0, 27434.725652744015, 27603.309917251427, 27638.72361276442, 27829.02598409046, 28090.157295281173, 46245.30632040589, 46382.0, 46514.76742616265, 46630.53369466397, 47144.0, 39282.0, 39694.60305396909, 40092.39861402023, 40169.1966160681, 40791.94060445419, 39714.2057158861, 39755.80122099371, 39807.0, 40079.1984160321, 40406.39390409205, 39389.212215756095, 39996.0, 40118.197636046534, 40133.0, 40152.79923600363, 32851.67148328582, 35190.648093518736, 35587.28825423529, 35874.64125358713, 36163.81918090393, 27045.864770676806, 27270.96475922076, 27672.308192295353, 27790.861045695452, 27896.58155127634], "value": 18376.85813267444, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.2477820025349, 384.83452115590285, 385.19109869274524, 397.1953540768367, 405.6795131845842, 13674.083865756045, 15116.0, 17677.204525796336, 19252.711209331854, 19304.90347548262, 17465.476035718948, 18008.0, 18194.27154420328, 18713.438596842083, 18721.531961700963, 5526.806561770339, 5549.500544950964, 5785.681787501686, 5787.565932555054, 5788.247527821377, 5305.681659100466, 5679.062954612484, 5687.146927960818, 5709.514691251248, 5715.857103572403, 5614.9157762633595, 5626.156076588524, 5642.633228840133, 5672.262605861253, 5703.31560212775, 5186.974065129669, 5435.076037073707, 5467.425920278393, 5551.99999999996, 5625.915611265835, 5237.240600112962, 5413.891722165574, 5417.702026388547, 5577.637453565505, 5614.185943038277, 12316.322602256872, 12484.75030499385, 12552.560660376843, 12617.747645047048, 12793.1684440512, 2184.213683074092, 2204.5039866030015, 2334.684817549643, 2336.2290444153386, 2403.020254883949, 9353.579088941015, 9395.953020234923, 9686.903130968742, 9836.95081524595, 10126.544305506197, 1841.6961201401753, 1883.1243471785685, 1961.803819618041, 1966.8426525878037, 2027.6147531969027, 72505.0, 77067.22932770601, 79186.0, 82911.0, 83636.0, 9990.750231244278, 10138.543765530569, 10416.635417760343, 10629.0, 10676.679699609023, 14257.643558910902, 14320.928395358165, 14378.137311761328, 14380.137191768526, 14431.927840360731, 7684.11632662251, 7750.689972401154, 7798.376129909594, 7815.68737250515, 7862.567558784207, 7162.820929476805, 7284.562926224444, 7377.40980721541, 7433.070866141732, 7468.439867009996, 4247.893802654959, 4438.1567502174485, 4450.154470650566, 4587.678862479661, 4594.770261486912, 1819.8908065515845, 1848.432525226326, 1860.4790658615339, 1867.6078023615194, 1896.6111947050822, 911.2573252799081, 973.3721749471692, 1051.5373235776387, 1071.5606601293432, 1100.1308965916996, 18471.261149553866, 18795.15421806022, 18855.717164242546, 18902.243910243436, 19255.711164332548, 948.2793077261331, 952.3428834104445, 969.6703120938914, 983.498415807943, 1059.6767985764416, 10303.484825758682, 10541.789164216827, 10642.132784027943, 10679.252452328417, 10747.623833165802, 446813.0, 458713.0, 476741.0, 481224.0, 486129.0, 77745.6112719444, 84082.57958710167, 87549.0, 94695.05304947, 97429.51285243529, 955.0926619711302, 990.5592011554933, 993.3940296419179, 996.940183588987, 1007.7581380468781, 16686.66626667484, 16803.0, 17099.7435038477, 17440.302387904343, 17600.119994000506, 40713.0, 41641.58358416377, 41727.0, 42248.36627450529, 43497.78251108724, 56212.15681764859, 58993.395627415324, 64408.677956609914, 64989.0, 65068.759924499056, 8187.672493100209, 8536.573171341532, 8567.100454452193, 8719.782005449915, 8885.155910188521, 9236.030216827405, 11943.641690749291, 12571.434285456993, 12714.745705086032, 12800.295983720986, 11304.321740695585, 11667.416629168338, 11883.287002779862, 12086.697832554257, 12172.878271217174, 10282.485875706334, 11155.49800258974, 11238.943805280922, 11587.710307242387, 11606.129540284344, 11727.76544469123, 11891.702707432383, 12163.57427490069, 12206.084543659439, 12280.87719122833, 8066.83866322682, 8139.552324621965, 8384.30375724843, 8398.370122240734, 8471.32229421657, 11166.218364714392, 11540.307581545134, 11746.471408786796, 11775.23460975034, 11888.76222475563], "value": 8827.56256846152, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.7281003014446, 1501.4369611395725, 1606.4216881922505, 1722.862171026318, 1738.313366220343, 8227.876581851277, 8734.650613975442, 8850.734477965656, 9438.339316247857, 9453.716388508356, 8923.063078376757, 9113.225375843062, 9133.086691330864, 9153.862692059625, 9259.351845370828, 2284.4060544258487, 2337.672725818387, 2339.836211465198, 2341.9648705269433, 2344.531093781242, 2326.5230627721276, 2326.697529321186, 2334.6031174700342, 2343.60158773009, 2353.8823058847074, 2266.3654176830514, 2281.087564974007, 2302.666113413554, 2303.3550605830396, 2321.8258630602686, 2263.6265016272296, 2287.874166920819, 2290.782375674325, 2294.8737819419925, 2305.0664480885266, 2269.761675024132, 2292.736335321426, 2301.2060839010514, 2306.031466783938, 2307.3308740465245, 9101.590428430736, 9245.491497967609, 9259.72220833376, 9264.814703705888, 9299.48852813095, 5253.238280449352, 5385.7576409061685, 5390.8921821563345, 5405.7567409466665, 5428.37573679028, 3332.266901281714, 3450.258194488197, 3510.912227194315, 3513.6837684608254, 3572.9464058039152, 1140.361397617337, 1202.0, 1218.8354572132826, 1223.2415902140729, 1234.154604096197, 12870.742585148244, 12939.67650808728, 12979.0, 13040.739185216338, 13043.413046412934, 4549.226631472658, 4661.557152070548, 4707.340972263886, 4757.785899634525, 4772.236442169236, 10833.891661083446, 10885.074768644596, 10889.237753357347, 10891.292066015683, 10893.0, 5286.7092309922555, 5313.0, 5362.436944120811, 5372.382176049804, 5374.48942350476, 4400.933985990213, 4829.975850120727, 4961.7271050092595, 4980.452150263468, 4998.90002199954, 3905.3556163232747, 3925.430812532167, 3998.0804414984136, 4031.314676505001, 4034.91930161401, 1222.468226321553, 1228.9139760216879, 1235.5428491458217, 1246.5076294863659, 1253.0852477691337, 968.3512046928574, 983.1446641421866, 988.9752756181009, 996.342414006752, 1015.2791518022287, 6282.937170628235, 6296.937030629635, 6342.23893132827, 6373.362663733589, 6404.871902562016, 1024.1653052761976, 1031.8710161229847, 1035.60193738454, 1042.213129087534, 1046.1526163807341, 4329.675274354436, 4371.672124590668, 4374.759388233678, 4398.758068306274, 4413.3159360299205, 10857.239993200557, 10932.508037138348, 11081.944590276997, 11083.556657733761, 11230.15773816967, 10898.618548350769, 11346.886531134747, 11350.09199264057, 11615.593454229062, 11689.883101169049, 8403.621837017348, 8582.656693732306, 8591.226789588967, 8606.35452341077, 8619.0, 6293.779717709858, 6497.610143391412, 6505.577137486048, 6506.316836732075, 6508.186476690414, 10375.740606484898, 10660.786784264115, 10722.571097156026, 10806.081483073713, 10875.456227188768, 10792.892071079188, 10811.027007569357, 10842.186835987175, 10978.176636752436, 11010.779784404427, 7506.662200201114, 7878.5272883624875, 8011.0, 8242.835143297221, 8343.290820280345, 9083.863742044006, 9085.0, 9146.451212927246, 9157.816843663222, 9196.310276729138, 7821.491603045783, 7999.880001800094, 8073.39449541275, 8099.757007289791, 8155.469894456842, 7802.882956755539, 7854.096778870503, 7872.291493765589, 7873.763787086396, 8060.717874874351, 7372.0, 7416.1471430783995, 7416.96291518539, 7449.329560339379, 7511.624418779148, 5318.122509785997, 5342.0, 5425.864353391197, 5474.5894057945015, 5500.889982200413, 5372.1941708744, 5400.108982017923, 5552.7778888845605, 5560.777568897361, 5562.16567514876], "value": 4807.748857706547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.28493311979565, 330.66437565870643, 331.5673046674091, 334.4164433064303, 338.89833050084985, 5543.41794111618, 5670.958454956218, 5675.51758100562, 5676.489115979561, 5731.283589551306, 5540.448674371182, 5582.637128586649, 5584.692841893694, 5601.187827764971, 5604.915926261099, 4111.48606424197, 4174.22776786294, 4279.8502052428175, 4288.506821715511, 4293.635041021517, 4307.1601037797645, 4312.929793699011, 4315.4389929309145, 4336.742344720027, 4341.934870976922, 4269.188854117723, 4295.140971805636, 4297.699161058727, 4303.935440968388, 4318.395424640537, 4051.5948405159543, 4255.63827074699, 4260.510041345223, 4269.124829409963, 4305.440292761937, 3693.261347730465, 3710.109573702292, 3713.551714831218, 3718.2563487302646, 3725.795081270529, 5434.483724046209, 5450.945490545123, 5491.450854914517, 5493.340799104133, 5512.200730894038, 4814.253790662453, 4892.780432865041, 4940.357753492059, 4941.777620007072, 4966.701997880139, 5867.237259156325, 5895.496648354642, 5896.616719913235, 5910.468057874812, 5916.745789815627, 4069.9389509157386, 4098.590140985878, 4142.855000074983, 4144.626983571493, 4153.771542565158, 5818.5345172386105, 6003.639781613074, 6032.45707886288, 6039.456448919618, 6053.4551890330085, 4215.57844215576, 4224.683148763855, 4229.915401691949, 4232.830686772495, 4246.681498887596, 4226.387173859835, 4276.57234276576, 4296.785160741951, 4297.59172878576, 4327.870163895088, 4661.021185551072, 4949.57928576075, 4959.0, 4968.378952630921, 4970.72661003641, 5819.359870414251, 5832.883342333214, 5884.617499862496, 5956.195913551702, 5967.283925928829, 1480.7926890235376, 1494.46817012563, 1495.7307684616874, 1497.3486533358025, 1497.6779992301708, 926.7636752628036, 928.5995701112564, 959.6161535385762, 969.95150242489, 995.711243739322, 5568.303962004749, 5624.71876406178, 5669.206311116447, 5683.715814209273, 5711.343195532484, 5985.6408615483215, 6028.487578555872, 6028.618695615208, 6039.184710064085, 6043.0, 5507.339119305629, 5727.541796656257, 5734.942650573441, 5777.422257774189, 5804.21643078179, 3226.3869864725625, 3239.5626590409993, 3242.492241107896, 3257.7556683248376, 3258.354530961849, 6169.475594574422, 6290.4653104485715, 6307.0, 6323.873522529524, 6347.0, 6178.382161783786, 6193.6464143625135, 6198.721057552421, 6199.938000620026, 6244.4380005798785, 5965.522758179335, 6181.660008699475, 6254.437100660963, 6265.843353916098, 6297.992321228581, 6077.149199112217, 6077.544184186292, 6119.969400153149, 6163.876722465615, 6175.672230470471, 6028.15605815195, 6038.969805150946, 6057.697115144137, 6086.391360863879, 6115.541334400027, 5895.7052147393315, 6310.810675679737, 6311.211098612674, 6319.304876463493, 6347.508335541052, 4184.430838435586, 4200.243956087934, 4203.516595591546, 4205.726627769308, 4210.852620158403, 5823.94176058234, 5942.7920022799, 6025.66858822769, 6097.695115244309, 6103.115048318058, 5846.35690074083, 5855.619384739978, 5918.704064796829, 5923.644581325134, 5927.347991720993, 5830.62100963436, 5865.946918578464, 5873.236479257669, 5878.0, 5878.559108066997, 5583.994880921473, 5706.0, 5759.539236861125, 5823.155642431739, 5840.678762667924, 5858.209141765978, 5876.706164691663, 5883.0, 5891.263592050994, 5896.260603122004, 5520.282363292747, 5761.769529218785, 5783.884322313446, 5792.7103644818435, 5844.590878638454], "value": 4454.406264988108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.8364784275698, 715.3204455767019, 774.1407038187614, 792.7146227358152, 811.3509192645882, 16762.91618541907, 17181.711371647114, 17278.0, 17921.103944802773, 18007.81992180078, 16454.67090658189, 16464.176791160455, 16502.42241521547, 16559.420420285292, 16580.17099145044, 652.044754434753, 783.7648705388389, 810.9472884262534, 815.213319147023, 816.96732130715, 800.671724592917, 803.7749430159536, 808.3694718119876, 810.0522388805083, 810.6109067647533, 843.6245870587591, 845.8858054162671, 845.9069502354736, 846.1792061700141, 849.966001359948, 833.72487079264, 839.8194388206534, 840.0507426607955, 842.5534466732641, 842.9452085614415, 616.9537284703621, 618.8947878860605, 620.7144713431827, 621.6394491195095, 622.0327390907138, 16045.598860028593, 16165.676686466204, 16168.434104806276, 16226.594335141597, 16236.918815405965, 15009.549713508612, 15029.398824047024, 15038.624034399227, 15198.848011519964, 15377.461788837338, 12335.568255111028, 12356.320402377865, 12366.319852408114, 12556.18384804994, 12703.491860325576, 3830.8276127574327, 3853.2871418787336, 3943.073377756225, 4020.979895100535, 4032.858849940238, 81637.59181204055, 82254.17745822585, 82503.0, 83369.16630833675, 84122.15877841205, 11447.828282575769, 11450.94274528622, 11672.241304315192, 11699.532018719327, 12021.639350819489, 21608.35174944754, 21910.45223869384, 21992.78007219939, 22060.117595296328, 22076.448088797908, 8708.956455217683, 8742.912570874338, 9307.3019523536, 9311.06889311077, 9320.0, 5034.194528875362, 5063.291139240509, 5165.535101840853, 5204.323437953118, 5208.427073021964, 3307.520409540603, 3363.5291059251726, 3366.983165084159, 3372.76390652652, 3377.3583019226758, 644.1014784375864, 654.7424183804061, 657.789507357641, 660.5475249454139, 661.5832025823701, 692.2039654397483, 721.5742711799958, 723.4802684937845, 737.3142977031413, 746.7125156814666, 9953.651622193189, 10181.134603558781, 10220.540075696463, 10222.897771022343, 10387.584496620051, 600.102846244858, 644.4103645164715, 712.3961919185385, 731.1664702239451, 732.7435397610793, 4698.412698412699, 4865.70805751656, 4941.950580494221, 4952.232403977389, 4952.331435256195, 110148.44925775481, 112923.43538282256, 114573.0, 116860.41569792097, 117756.41121794336, 68415.89504629739, 74591.0, 97761.0, 97863.51068244613, 100819.0, 86584.0, 86735.0, 86762.56618716866, 88618.55690721505, 88746.55626721826, 8518.914810851813, 8633.39566230358, 8659.870101948602, 8676.305895528469, 8777.91222087771, 51540.39217254756, 52095.739521303665, 52584.474155259486, 53465.0, 53983.460165397846, 63661.68169159124, 67020.66489667521, 68016.6599167001, 68097.65951170212, 77226.0, 12741.299228542519, 13567.728645427234, 13570.253636050113, 13638.0, 14168.0, 13396.196228226338, 13397.0, 15213.923930380277, 15277.0, 15820.525384238492, 12756.48974041065, 13549.729005420033, 13591.320433978064, 13618.659533511742, 13670.931645342107, 13767.931160344135, 14459.493917712829, 14560.271986400849, 14780.778288325899, 15053.6989260212, 12527.373631318216, 12680.936595316964, 12726.363681816058, 12853.807192892302, 13104.737905242033, 10035.849462257926, 10151.7462063449, 10325.173986081245, 10620.52207650673, 10700.946495267473, 11255.268407553483, 11551.249168804, 11872.703182420508, 11884.881151188378, 12246.693832654255], "value": 7650.405707285937, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 110.0, 112.0, 113.0, 112.0, 110.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 151.0, 186.0, 141.0, 159.0, 155.0, 130.0, 203.0, 126.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 164.0, 171.0, 163.0, 163.0, 164.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 155.0, 77.0, 76.0, 77.0, 76.0, 158.0, 79.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 140.0, 86.0, 85.0, 85.0, 149.0, 86.0, 85.0, 140.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 149.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 100.0, 97.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 61.0, 55.0, 55.0, 56.0, 54.0, 59.0, 55.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 81.0, 80.0, 81.0, 86.0, 81.0, 81.0, 109.0, 87.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 131.0, 130.0, 124.0, 125.0, 132.0, 133.0, 136.0, 134.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 160.0, 158.0, 160.0, 160.0, 166.0, 160.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 65.0, 62.0, 65.0, 62.0, 63.0, 63.0, 63.0], "value": 63.9, "unit": "score"}]}]} 06:02:21 INFO - Return code: 0 06:02:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:02:21 ERROR - # TBPL SUCCESS # 06:02:21 INFO - Running post-action listener: _resource_record_post_action 06:02:21 INFO - ##### 06:02:21 INFO - ##### Finished run-tests step (success) 06:02:21 INFO - ##### 06:02:21 INFO - Running post-run listener: _resource_record_post_run 06:02:22 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 541282304; Read time: 200; Write time: 502336 06:02:22 INFO - TinderboxPrint: CPU usage
13.4% 06:02:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 200 06:02:22 INFO - TinderboxPrint: I/O write bytes / time
541,282,304 / 502,336 06:02:22 INFO - TinderboxPrint: CPU idle
8,235.9 (86.5%) 06:02:22 INFO - TinderboxPrint: CPU user
1,221.2 (12.8%) 06:02:22 INFO - TinderboxPrint: Swap in / out
0 / 0 06:02:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 238288896; Read time: 0; Write time: 249456 06:02:22 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292216832; Read time: 200; Write time: 251644 06:02:22 INFO - Running post-run listener: _upload_blobber_files 06:02:22 INFO - Blob upload gear active. 06:02:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:02:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:02:22 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:02:22 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:02:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:02:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:02:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:02:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:23 INFO - (blobuploader) - INFO - Done attempting. 06:02:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:02:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:27 INFO - (blobuploader) - INFO - Done attempting. 06:02:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:02:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:02:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:28 INFO - (blobuploader) - INFO - Done attempting. 06:02:28 INFO - (blobuploader) - INFO - Iteration through files over. 06:02:28 INFO - Return code: 0 06:02:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:02:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:02:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b660835bf7fa9770fca902e4de4baec629485b8d6fcfd86ab0d58acfe3305631e643b4d914629cf863df85ec2e5044c43ed4245d50cdc08bbc0424977195862d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9275a1e8fedcde38cdef48632ce4cbad16dc0718530dd5b4373035116ddf6dd854ae2ce36c7d96bc34ff832291bb98ba42f73e94b7c01aecded1534f6c67f889", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36a46fa12d449a945055d4b797abb6c24de87e31c78cff1ea0af5a8e14f970d0dcab142b8d84e82c69a516e078d7f6a476863eb08a7fdb96e379f1aa19a66c07"} 06:02:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:02:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:02:28 INFO - Contents: 06:02:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b660835bf7fa9770fca902e4de4baec629485b8d6fcfd86ab0d58acfe3305631e643b4d914629cf863df85ec2e5044c43ed4245d50cdc08bbc0424977195862d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9275a1e8fedcde38cdef48632ce4cbad16dc0718530dd5b4373035116ddf6dd854ae2ce36c7d96bc34ff832291bb98ba42f73e94b7c01aecded1534f6c67f889", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36a46fa12d449a945055d4b797abb6c24de87e31c78cff1ea0af5a8e14f970d0dcab142b8d84e82c69a516e078d7f6a476863eb08a7fdb96e379f1aa19a66c07"} 06:02:28 INFO - Running post-run listener: copy_logs_to_upload_dir 06:02:28 INFO - Copying logs to upload dir... 06:02:28 INFO - mkdir: /builds/slave/test/build/upload/logs 06:02:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.690508 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-10 06:02:27.850456) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 06:02:27.853948) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b660835bf7fa9770fca902e4de4baec629485b8d6fcfd86ab0d58acfe3305631e643b4d914629cf863df85ec2e5044c43ed4245d50cdc08bbc0424977195862d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9275a1e8fedcde38cdef48632ce4cbad16dc0718530dd5b4373035116ddf6dd854ae2ce36c7d96bc34ff832291bb98ba42f73e94b7c01aecded1534f6c67f889", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36a46fa12d449a945055d4b797abb6c24de87e31c78cff1ea0af5a8e14f970d0dcab142b8d84e82c69a516e078d7f6a476863eb08a7fdb96e379f1aa19a66c07"} build_url:https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b660835bf7fa9770fca902e4de4baec629485b8d6fcfd86ab0d58acfe3305631e643b4d914629cf863df85ec2e5044c43ed4245d50cdc08bbc0424977195862d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9275a1e8fedcde38cdef48632ce4cbad16dc0718530dd5b4373035116ddf6dd854ae2ce36c7d96bc34ff832291bb98ba42f73e94b7c01aecded1534f6c67f889", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36a46fa12d449a945055d4b797abb6c24de87e31c78cff1ea0af5a8e14f970d0dcab142b8d84e82c69a516e078d7f6a476863eb08a7fdb96e379f1aa19a66c07"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 06:02:27.884062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 06:02:27.884804) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465562146.852032-225167660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 06:02:27.969379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 06:02:27.970149) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 06:02:27.970704) ========= ========= Total master_lag: 0.30 =========