builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1465907785.45 results: success (0) buildid: 20160614030210 builduid: b7e6fc41a77b4e238196b6cf83d8e8de revision: ddb6b30149221f00eb5dd180530e9033093d4c2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:25.450487) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:25.451267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:25.451751) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:25.489220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:25.489510) ========= 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=62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 05:36:26-- 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% 82.2K=0.1s 2016-06-14 05:36:26 (82.2 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.271450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:25.780844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:25.781144) ========= 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=62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019083 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:25.833300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 05:36:25.833617) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ddb6b30149221f00eb5dd180530e9033093d4c2b --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 ddb6b30149221f00eb5dd180530e9033093d4c2b --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=62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 05:36:26,402 truncating revision to first 12 chars 2016-06-14 05:36:26,402 Setting DEBUG logging. 2016-06-14 05:36:26,402 attempt 1/10 2016-06-14 05:36:26,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ddb6b3014922?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 05:36:26,706 unpacking tar archive at: mozilla-central-ddb6b3014922/testing/mozharness/ program finished with exit code 0 elapsedTime=1.431907 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 05:36:27.279283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:27.279639) ========= script_repo_revision: ddb6b30149221f00eb5dd180530e9033093d4c2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:27.280047) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:27.280342) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 05:36:27.289523) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-14 05:36:27.289849) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:36:27 INFO - MultiFileLogger online at 20160614 05:36:27 in /builds/slave/test 05:36:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:36:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:36:27 INFO - {'append_to_log': False, 05:36:27 INFO - 'base_work_dir': '/builds/slave/test', 05:36:27 INFO - 'blob_upload_branch': 'Firefox', 05:36:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:36:27 INFO - 'branch': 'Firefox', 05:36:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:27 INFO - 'config_files': ('talos/linux_config.py',), 05:36:27 INFO - 'default_actions': ('clobber', 05:36:27 INFO - 'read-buildbot-config', 05:36:27 INFO - 'download-and-extract', 05:36:27 INFO - 'populate-webroot', 05:36:27 INFO - 'create-virtualenv', 05:36:27 INFO - 'install', 05:36:27 INFO - 'run-tests'), 05:36:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:27 INFO - 'download_minidump_stackwalk': True, 05:36:27 INFO - 'download_symbols': 'ondemand', 05:36:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:36:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:36:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:36:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:36:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:27 INFO - 'installer_path': 'installer.exe', 05:36:27 INFO - 'log_level': 'info', 05:36:27 INFO - 'log_name': 'talos', 05:36:27 INFO - 'log_to_console': True, 05:36:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:36:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:36:27 INFO - 'opt_config_files': (), 05:36:27 INFO - 'pip_index': False, 05:36:27 INFO - 'sps_profile': False, 05:36:27 INFO - 'sps_profile_interval': 0, 05:36:27 INFO - 'suite': 'dromaeojs', 05:36:27 INFO - 'system_bits': '32', 05:36:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:27 INFO - 'title': 'talos-linux64-ix-018', 05:36:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:27 INFO - 'use_talos_json': True, 05:36:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:36:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:27 INFO - 'work_dir': 'build'} 05:36:27 INFO - ##### 05:36:27 INFO - ##### Running clobber step. 05:36:27 INFO - ##### 05:36:27 INFO - Running pre-action listener: _resource_record_pre_action 05:36:27 INFO - Running main action method: clobber 05:36:27 INFO - rmtree: /builds/slave/test/build 05:36:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:36:28 INFO - Running post-action listener: _resource_record_post_action 05:36:28 INFO - ##### 05:36:28 INFO - ##### Finished clobber step (success) 05:36:28 INFO - ##### 05:36:28 INFO - ##### 05:36:28 INFO - ##### Running read-buildbot-config step. 05:36:28 INFO - ##### 05:36:28 INFO - Running pre-action listener: _resource_record_pre_action 05:36:28 INFO - Running main action method: read_buildbot_config 05:36:28 INFO - Using buildbot properties: 05:36:28 INFO - { 05:36:28 INFO - "project": "", 05:36:28 INFO - "product": "firefox", 05:36:28 INFO - "script_repo_revision": "production", 05:36:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:36:28 INFO - "repository": "", 05:36:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:36:28 INFO - "buildid": "20160614030210", 05:36:28 INFO - "stage_platform": "linux64-pgo", 05:36:28 INFO - "basedir": "/builds/slave/test", 05:36:28 INFO - "nightly_build": "True", 05:36:28 INFO - "buildnumber": 478, 05:36:28 INFO - "slavename": "talos-linux64-ix-018", 05:36:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:36:28 INFO - "platform": "ubuntu64_hw", 05:36:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:36:28 INFO - "branch": "mozilla-central", 05:36:28 INFO - "repo_path": "mozilla-central", 05:36:28 INFO - "revision": "ddb6b30149221f00eb5dd180530e9033093d4c2b", 05:36:28 INFO - "pgo_build": "True", 05:36:28 INFO - "builduid": "b7e6fc41a77b4e238196b6cf83d8e8de", 05:36:28 INFO - "slavebuilddir": "test" 05:36:28 INFO - } 05:36:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:36:28 INFO - Running post-action listener: _resource_record_post_action 05:36:28 INFO - ##### 05:36:28 INFO - ##### Finished read-buildbot-config step (success) 05:36:28 INFO - ##### 05:36:28 INFO - ##### 05:36:28 INFO - ##### Running download-and-extract step. 05:36:28 INFO - ##### 05:36:28 INFO - Running pre-action listener: _resource_record_pre_action 05:36:28 INFO - Running main action method: download_and_extract 05:36:28 INFO - mkdir: /builds/slave/test/build/tests 05:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:28 INFO - https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:36:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:36:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:36:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/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:36:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/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:36:33 INFO - Downloaded 1361 bytes. 05:36:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:36:33 INFO - Using the following test package requirements: 05:36:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:36:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:36:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:36:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:33 INFO - u'jsshell-linux-x86_64.zip'], 05:36:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:36:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:36:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:36:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:36:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:36:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:36:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:36:33 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:36:33 INFO - https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:36:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:36:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:36:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/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:36:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/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:36:40 INFO - Downloaded 24219879 bytes. 05:36:40 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:36:40 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:36:41 INFO - Return code: 0 05:36:41 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:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:41 INFO - https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:36:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:36:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:36:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/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:36:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/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:36:43 INFO - Downloaded 24219879 bytes. 05:36:43 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:36:43 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:36:44 INFO - Return code: 0 05:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:44 INFO - https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/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:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/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:36:46 INFO - Downloaded 14405384 bytes. 05:36:46 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:36:46 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:36:46 INFO - Return code: 0 05:36:46 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:36:46 INFO - https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:36:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:36:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:36:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/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:36:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/McDXEmueQka-kMw0Ryl8SQ/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:36:47 INFO - Downloaded 59337147 bytes. 05:36:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:36:47 INFO - mkdir: /builds/slave/test/properties 05:36:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:36:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:36:47 INFO - Contents: 05:36:47 INFO - build_url:https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:36:48 INFO - Running post-action listener: _resource_record_post_action 05:36:48 INFO - Running post-action listener: set_extra_try_arguments 05:36:48 INFO - ##### 05:36:48 INFO - ##### Finished download-and-extract step (success) 05:36:48 INFO - ##### 05:36:48 INFO - ##### 05:36:48 INFO - ##### Running populate-webroot step. 05:36:48 INFO - ##### 05:36:48 INFO - Running pre-action listener: _resource_record_pre_action 05:36:48 INFO - Running main action method: populate_webroot 05:36:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:36:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:36:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:36:48 INFO - '--tppagecycles', 05:36:48 INFO - '7'], 05:36:48 INFO - 'tests': ['tsvgm']}}, 05:36:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:36:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:36:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:36:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:36:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:48 INFO - 'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:48 INFO - 'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['damp', 'tps']}, 05:36:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:48 INFO - 'tests': ['damp', 'tps']}, 05:36:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['dromaeo_dom']}, 05:36:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:36:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['basic_compositor_video']}, 05:36:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:36:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['a11yr', 05:36:48 INFO - 'ts_paint', 05:36:48 INFO - 'tpaint', 05:36:48 INFO - 'sessionrestore', 05:36:48 INFO - 'sessionrestore_no_auto_restore', 05:36:48 INFO - 'tabpaint']}, 05:36:48 INFO - 'other-e10s': {'tests': ['a11yr', 05:36:48 INFO - 'ts_paint', 05:36:48 INFO - 'tpaint', 05:36:48 INFO - 'sessionrestore', 05:36:48 INFO - 'sessionrestore_no_auto_restore', 05:36:48 INFO - 'tabpaint']}, 05:36:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:36:48 INFO - 'ts_paint', 05:36:48 INFO - 'tpaint', 05:36:48 INFO - 'sessionrestore', 05:36:48 INFO - 'sessionrestore_no_auto_restore', 05:36:48 INFO - 'tabpaint']}, 05:36:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:36:48 INFO - 'ts_paint', 05:36:48 INFO - 'tpaint', 05:36:48 INFO - 'sessionrestore', 05:36:48 INFO - 'sessionrestore_no_auto_restore', 05:36:48 INFO - 'tabpaint']}, 05:36:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['a11yr', 05:36:48 INFO - 'ts_paint', 05:36:48 INFO - 'tpaint', 05:36:48 INFO - 'sessionrestore', 05:36:48 INFO - 'sessionrestore_no_auto_restore', 05:36:48 INFO - 'tabpaint']}, 05:36:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['a11yr', 05:36:48 INFO - 'ts_paint', 05:36:48 INFO - 'tpaint', 05:36:48 INFO - 'sessionrestore', 05:36:48 INFO - 'sessionrestore_no_auto_restore', 05:36:48 INFO - 'tabpaint']}, 05:36:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['tsvgx', 05:36:48 INFO - 'tsvgr_opacity', 05:36:48 INFO - 'tart', 05:36:48 INFO - 'tscrollx', 05:36:48 INFO - 'cart']}, 05:36:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:36:48 INFO - 'tsvgr_opacity', 05:36:48 INFO - 'tart', 05:36:48 INFO - 'tscrollx', 05:36:48 INFO - 'cart']}, 05:36:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:48 INFO - 'talos_options': ['--disable-e10s'], 05:36:48 INFO - 'tests': ['tp5o']}, 05:36:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:48 INFO - 'tests': ['tp5o']}, 05:36:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:48 INFO - 'talos_options': ['--disable-e10s', 05:36:48 INFO - '--xperf_path', 05:36:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:48 INFO - 'tests': ['tp5n']}, 05:36:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:48 INFO - 'talos_options': ['--xperf_path', 05:36:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:48 INFO - 'tests': ['tp5n']}}, 05:36:48 INFO - 'talos.zip': {'path': '', 05:36:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:36:48 INFO - Running post-action listener: _resource_record_post_action 05:36:48 INFO - ##### 05:36:48 INFO - ##### Finished populate-webroot step (success) 05:36:48 INFO - ##### 05:36:48 INFO - ##### 05:36:48 INFO - ##### Running create-virtualenv step. 05:36:48 INFO - ##### 05:36:48 INFO - Running pre-action listener: _resource_record_pre_action 05:36:48 INFO - Running main action method: create_virtualenv 05:36:48 INFO - Creating virtualenv /builds/slave/test/build/venv 05:36:48 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:36:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:36:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:36:48 INFO - Using real prefix '/usr' 05:36:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:36:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:50 INFO - Installing pip.................done. 05:36:50 INFO - Return code: 0 05:36:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:50 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 0x7fbabe7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', '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:36:50 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:36:50 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:36:50 INFO - Using env: {'DISPLAY': ':0', 05:36:50 INFO - 'HOME': '/home/cltbld', 05:36:50 INFO - 'LANG': 'en_US.UTF-8', 05:36:50 INFO - 'LANGUAGE': 'en_US:en', 05:36:50 INFO - 'LOGNAME': 'cltbld', 05:36:50 INFO - 'MAIL': '/var/mail/cltbld', 05:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:50 INFO - 'MOZ_NO_REMOTE': '1', 05:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:50 INFO - 'NO_EM_RESTART': '1', 05:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:50 INFO - 'PWD': '/builds/slave/test', 05:36:50 INFO - 'SHELL': '/bin/bash', 05:36:50 INFO - 'SHLVL': '1', 05:36:50 INFO - 'TERM': 'linux', 05:36:50 INFO - 'TMOUT': '86400', 05:36:50 INFO - 'USER': 'cltbld', 05:36:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:50 INFO - '_': '/tools/buildbot/bin/python'} 05:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:51 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:36:51 INFO - Cleaning up... 05:36:51 INFO - Return code: 0 05:36:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:51 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 0x7fbabe7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', '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:36:51 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:36:51 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:36:51 INFO - Using env: {'DISPLAY': ':0', 05:36:51 INFO - 'HOME': '/home/cltbld', 05:36:51 INFO - 'LANG': 'en_US.UTF-8', 05:36:51 INFO - 'LANGUAGE': 'en_US:en', 05:36:51 INFO - 'LOGNAME': 'cltbld', 05:36:51 INFO - 'MAIL': '/var/mail/cltbld', 05:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:51 INFO - 'MOZ_NO_REMOTE': '1', 05:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:51 INFO - 'NO_EM_RESTART': '1', 05:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:51 INFO - 'PWD': '/builds/slave/test', 05:36:51 INFO - 'SHELL': '/bin/bash', 05:36:51 INFO - 'SHLVL': '1', 05:36:51 INFO - 'TERM': 'linux', 05:36:51 INFO - 'TMOUT': '86400', 05:36:51 INFO - 'USER': 'cltbld', 05:36:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:51 INFO - '_': '/tools/buildbot/bin/python'} 05:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:51 INFO - Downloading/unpacking psutil>=3.1.1 05:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:53 INFO - Installing collected packages: psutil 05:36:53 INFO - Running setup.py install for psutil 05:36:53 INFO - building 'psutil._psutil_linux' extension 05:36:53 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:36:53 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:36:53 INFO - building 'psutil._psutil_posix' extension 05:36:53 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:36:53 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:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:53 INFO - Successfully installed psutil 05:36:53 INFO - Cleaning up... 05:36:53 INFO - Return code: 0 05:36:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:36: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:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabe7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', '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:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:36:53 INFO - Using env: {'DISPLAY': ':0', 05:36:53 INFO - 'HOME': '/home/cltbld', 05:36:53 INFO - 'LANG': 'en_US.UTF-8', 05:36:53 INFO - 'LANGUAGE': 'en_US:en', 05:36:53 INFO - 'LOGNAME': 'cltbld', 05:36:53 INFO - 'MAIL': '/var/mail/cltbld', 05:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:53 INFO - 'MOZ_NO_REMOTE': '1', 05:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:53 INFO - 'NO_EM_RESTART': '1', 05:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:53 INFO - 'PWD': '/builds/slave/test', 05:36:53 INFO - 'SHELL': '/bin/bash', 05:36:53 INFO - 'SHLVL': '1', 05:36:53 INFO - 'TERM': 'linux', 05:36:53 INFO - 'TMOUT': '86400', 05:36:53 INFO - 'USER': 'cltbld', 05:36:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:53 INFO - '_': '/tools/buildbot/bin/python'} 05:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:36:56 INFO - Installing collected packages: mozsystemmonitor 05:36:56 INFO - Running setup.py install for mozsystemmonitor 05:36:56 INFO - Successfully installed mozsystemmonitor 05:36:56 INFO - Cleaning up... 05:36:56 INFO - Return code: 0 05:36:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbabe7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', '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:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:36:56 INFO - Using env: {'DISPLAY': ':0', 05:36:56 INFO - 'HOME': '/home/cltbld', 05:36:56 INFO - 'LANG': 'en_US.UTF-8', 05:36:56 INFO - 'LANGUAGE': 'en_US:en', 05:36:56 INFO - 'LOGNAME': 'cltbld', 05:36:56 INFO - 'MAIL': '/var/mail/cltbld', 05:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:56 INFO - 'MOZ_NO_REMOTE': '1', 05:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:56 INFO - 'NO_EM_RESTART': '1', 05:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:56 INFO - 'PWD': '/builds/slave/test', 05:36:56 INFO - 'SHELL': '/bin/bash', 05:36:56 INFO - 'SHLVL': '1', 05:36:56 INFO - 'TERM': 'linux', 05:36:56 INFO - 'TMOUT': '86400', 05:36:56 INFO - 'USER': 'cltbld', 05:36:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:56 INFO - '_': '/tools/buildbot/bin/python'} 05:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:56 INFO - Downloading/unpacking jsonschema==2.5.1 05:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:58 INFO - warning: no files found matching '*.txt' 05:36:58 INFO - no previously-included directories found matching 'build' 05:36:58 INFO - no previously-included directories found matching 'dist' 05:36:58 INFO - no previously-included directories found matching '.git*' 05:36:58 INFO - Installing collected packages: jsonschema, functools32 05:36:58 INFO - Running setup.py install for functools32 05:36:58 INFO - warning: no files found matching '*.txt' 05:36:58 INFO - no previously-included directories found matching 'build' 05:36:58 INFO - no previously-included directories found matching 'dist' 05:36:58 INFO - no previously-included directories found matching '.git*' 05:36:58 INFO - Successfully installed jsonschema functools32 05:36:58 INFO - Cleaning up... 05:36:58 INFO - Return code: 0 05:36:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:36:58 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:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:58 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:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:58 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 0x7fbabe7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', '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:36:58 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:36:58 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:36:58 INFO - Using env: {'DISPLAY': ':0', 05:36:58 INFO - 'HOME': '/home/cltbld', 05:36:58 INFO - 'LANG': 'en_US.UTF-8', 05:36:58 INFO - 'LANGUAGE': 'en_US:en', 05:36:58 INFO - 'LOGNAME': 'cltbld', 05:36:58 INFO - 'MAIL': '/var/mail/cltbld', 05:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:58 INFO - 'MOZ_NO_REMOTE': '1', 05:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:58 INFO - 'NO_EM_RESTART': '1', 05:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:58 INFO - 'PWD': '/builds/slave/test', 05:36:58 INFO - 'SHELL': '/bin/bash', 05:36:58 INFO - 'SHLVL': '1', 05:36:58 INFO - 'TERM': 'linux', 05:36:58 INFO - 'TMOUT': '86400', 05:36:58 INFO - 'USER': 'cltbld', 05:36:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:58 INFO - '_': '/tools/buildbot/bin/python'} 05:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:36:58 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:37:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:37:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:37:02 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:37:02 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:37:02 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:37:02 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:37:02 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:37:02 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:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:37:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:37:02 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:37:02 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:37:02 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:37:02 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:37:02 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:37:02 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:37:02 INFO - Downloading docopt-0.6.1.tar.gz 05:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:37:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:37:02 INFO - Running setup.py install for blobuploader 05:37:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:37:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:37:02 INFO - Running setup.py install for requests 05:37:03 INFO - Running setup.py install for docopt 05:37:03 INFO - Successfully installed blobuploader requests docopt 05:37:03 INFO - Cleaning up... 05:37:03 INFO - Return code: 0 05:37:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:03 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 0x7fbabe7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', '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:37:03 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:37:03 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:37:03 INFO - Using env: {'DISPLAY': ':0', 05:37:03 INFO - 'HOME': '/home/cltbld', 05:37:03 INFO - 'LANG': 'en_US.UTF-8', 05:37:03 INFO - 'LANGUAGE': 'en_US:en', 05:37:03 INFO - 'LOGNAME': 'cltbld', 05:37:03 INFO - 'MAIL': '/var/mail/cltbld', 05:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:03 INFO - 'MOZ_NO_REMOTE': '1', 05:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:03 INFO - 'NO_EM_RESTART': '1', 05:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:03 INFO - 'PWD': '/builds/slave/test', 05:37:03 INFO - 'SHELL': '/bin/bash', 05:37:03 INFO - 'SHLVL': '1', 05:37:03 INFO - 'TERM': 'linux', 05:37:03 INFO - 'TMOUT': '86400', 05:37:03 INFO - 'USER': 'cltbld', 05:37:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:03 INFO - '_': '/tools/buildbot/bin/python'} 05:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:03 INFO - Running setup.py (path:/tmp/pip-ZAabMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:03 INFO - Running setup.py (path:/tmp/pip-rn76YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:03 INFO - Running setup.py (path:/tmp/pip-bnqUPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:03 INFO - Running setup.py (path:/tmp/pip-KVJo86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:03 INFO - Running setup.py (path:/tmp/pip-MixN_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:03 INFO - Running setup.py (path:/tmp/pip-UXu2bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:04 INFO - Running setup.py (path:/tmp/pip-_k5F8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:04 INFO - Running setup.py (path:/tmp/pip-lPjTn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:04 INFO - Running setup.py (path:/tmp/pip-kffthq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:04 INFO - Running setup.py (path:/tmp/pip-swjjp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:04 INFO - Running setup.py (path:/tmp/pip-9HFlKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:04 INFO - Running setup.py (path:/tmp/pip-adTtzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:04 INFO - Running setup.py (path:/tmp/pip-Xp42Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:04 INFO - Running setup.py (path:/tmp/pip-s8lzpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:04 INFO - Running setup.py (path:/tmp/pip-pieQ36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:04 INFO - Running setup.py (path:/tmp/pip-QBOF9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:04 INFO - Running setup.py (path:/tmp/pip-QhiZLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:37:04 INFO - Running setup.py install for manifestparser 05:37:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:37:04 INFO - Running setup.py install for mozcrash 05:37:05 INFO - Running setup.py install for mozdebug 05:37:05 INFO - Running setup.py install for mozdevice 05:37:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:37:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:37:05 INFO - Running setup.py install for mozfile 05:37:05 INFO - Running setup.py install for mozhttpd 05:37:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:37:05 INFO - Running setup.py install for mozinfo 05:37:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:37:05 INFO - Running setup.py install for mozInstall 05:37:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:37:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:37:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:37:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:37:05 INFO - Running setup.py install for mozleak 05:37:05 INFO - Running setup.py install for mozlog 05:37:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:37:05 INFO - Running setup.py install for moznetwork 05:37:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:37:06 INFO - Running setup.py install for mozprocess 05:37:06 INFO - Running setup.py install for mozprofile 05:37:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:37:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:37:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:37:06 INFO - Running setup.py install for mozrunner 05:37:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:37:06 INFO - Running setup.py install for mozscreenshot 05:37:06 INFO - Running setup.py install for moztest 05:37:06 INFO - Running setup.py install for mozversion 05:37:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:37:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:37:06 INFO - Cleaning up... 05:37:06 INFO - Return code: 0 05:37:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37: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:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:06 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 0x7fbabe7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', '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:37:06 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:37:06 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:37:06 INFO - Using env: {'DISPLAY': ':0', 05:37:06 INFO - 'HOME': '/home/cltbld', 05:37:06 INFO - 'LANG': 'en_US.UTF-8', 05:37:06 INFO - 'LANGUAGE': 'en_US:en', 05:37:06 INFO - 'LOGNAME': 'cltbld', 05:37:06 INFO - 'MAIL': '/var/mail/cltbld', 05:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:06 INFO - 'MOZ_NO_REMOTE': '1', 05:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:06 INFO - 'NO_EM_RESTART': '1', 05:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:06 INFO - 'PWD': '/builds/slave/test', 05:37:06 INFO - 'SHELL': '/bin/bash', 05:37:06 INFO - 'SHLVL': '1', 05:37:06 INFO - 'TERM': 'linux', 05:37:06 INFO - 'TMOUT': '86400', 05:37:06 INFO - 'USER': 'cltbld', 05:37:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:06 INFO - '_': '/tools/buildbot/bin/python'} 05:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:06 INFO - Running setup.py (path:/tmp/pip-LoMXwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:06 INFO - Running setup.py (path:/tmp/pip-O3ulsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:07 INFO - Running setup.py (path:/tmp/pip-j4q9qF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:07 INFO - Running setup.py (path:/tmp/pip-rrORVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:07 INFO - Running setup.py (path:/tmp/pip-Umks_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:07 INFO - Running setup.py (path:/tmp/pip-0ewX_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:07 INFO - Running setup.py (path:/tmp/pip-3r97Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:07 INFO - Running setup.py (path:/tmp/pip-7mvz0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:07 INFO - Running setup.py (path:/tmp/pip-QEiXYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:07 INFO - Running setup.py (path:/tmp/pip-lYSBYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:07 INFO - Running setup.py (path:/tmp/pip-TWwL42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:07 INFO - Running setup.py (path:/tmp/pip-fwmXde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:07 INFO - Running setup.py (path:/tmp/pip-wPr5mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:07 INFO - Running setup.py (path:/tmp/pip-KvmUso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:07 INFO - Running setup.py (path:/tmp/pip-L4X7T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:07 INFO - Running setup.py (path:/tmp/pip-iHB0NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:08 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:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:08 INFO - Running setup.py (path:/tmp/pip-7sXf19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:08 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:37:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:10 INFO - Downloading blessings-1.6.tar.gz 05:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:37:10 INFO - Installing collected packages: blessings 05:37:10 INFO - Running setup.py install for blessings 05:37:10 INFO - Successfully installed blessings 05:37:10 INFO - Cleaning up... 05:37:10 INFO - Return code: 0 05:37:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:37:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:10 INFO - Reading from file tmpfile_stdout 05:37:10 INFO - Current package versions: 05:37:10 INFO - argparse == 1.2.1 05:37:10 INFO - blessings == 1.6 05:37:10 INFO - blobuploader == 1.2.4 05:37:10 INFO - docopt == 0.6.1 05:37:10 INFO - functools32 == 3.2.3-2 05:37:10 INFO - jsonschema == 2.5.1 05:37:10 INFO - manifestparser == 1.1 05:37:10 INFO - mozInstall == 1.12 05:37:10 INFO - mozcrash == 0.17 05:37:10 INFO - mozdebug == 0.1 05:37:10 INFO - mozdevice == 0.48 05:37:10 INFO - mozfile == 1.2 05:37:10 INFO - mozhttpd == 0.7 05:37:10 INFO - mozinfo == 0.9 05:37:10 INFO - mozleak == 0.1 05:37:10 INFO - mozlog == 3.2 05:37:10 INFO - moznetwork == 0.27 05:37:10 INFO - mozprocess == 0.22 05:37:10 INFO - mozprofile == 0.28 05:37:10 INFO - mozrunner == 6.11 05:37:10 INFO - mozscreenshot == 0.1 05:37:10 INFO - mozsystemmonitor == 0.3 05:37:10 INFO - moztest == 0.7 05:37:10 INFO - mozversion == 1.4 05:37:10 INFO - psutil == 3.1.1 05:37:10 INFO - requests == 1.2.3 05:37:10 INFO - wsgiref == 0.1.2 05:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:10 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 0x7fbabe7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', '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:37:10 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:37:10 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:37:10 INFO - Using env: {'DISPLAY': ':0', 05:37:10 INFO - 'HOME': '/home/cltbld', 05:37:10 INFO - 'LANG': 'en_US.UTF-8', 05:37:10 INFO - 'LANGUAGE': 'en_US:en', 05:37:10 INFO - 'LOGNAME': 'cltbld', 05:37:10 INFO - 'MAIL': '/var/mail/cltbld', 05:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:10 INFO - 'MOZ_NO_REMOTE': '1', 05:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:10 INFO - 'NO_EM_RESTART': '1', 05:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:10 INFO - 'PWD': '/builds/slave/test', 05:37:10 INFO - 'SHELL': '/bin/bash', 05:37:10 INFO - 'SHLVL': '1', 05:37:10 INFO - 'TERM': 'linux', 05:37:10 INFO - 'TMOUT': '86400', 05:37:10 INFO - 'USER': 'cltbld', 05:37:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:10 INFO - '_': '/tools/buildbot/bin/python'} 05:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:10 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:37:10 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:37:10 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:37:10 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:37:10 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:37:10 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:37:10 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:37:10 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:37:10 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:37:10 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:37:10 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:37:10 INFO - Cleaning up... 05:37:10 INFO - Return code: 0 05:37:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:10 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 0x7fbabe7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', '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:37:10 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:37:10 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:37:10 INFO - Using env: {'DISPLAY': ':0', 05:37:10 INFO - 'HOME': '/home/cltbld', 05:37:10 INFO - 'LANG': 'en_US.UTF-8', 05:37:10 INFO - 'LANGUAGE': 'en_US:en', 05:37:10 INFO - 'LOGNAME': 'cltbld', 05:37:10 INFO - 'MAIL': '/var/mail/cltbld', 05:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:10 INFO - 'MOZ_NO_REMOTE': '1', 05:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:10 INFO - 'NO_EM_RESTART': '1', 05:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:10 INFO - 'PWD': '/builds/slave/test', 05:37:10 INFO - 'SHELL': '/bin/bash', 05:37:10 INFO - 'SHLVL': '1', 05:37:10 INFO - 'TERM': 'linux', 05:37:10 INFO - 'TMOUT': '86400', 05:37:10 INFO - 'USER': 'cltbld', 05:37:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:10 INFO - '_': '/tools/buildbot/bin/python'} 05:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:37:10 INFO - Cleaning up... 05:37:10 INFO - Return code: 0 05:37:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:10 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 0x7fbabe7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, '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': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', '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:37:10 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:37:10 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:37:10 INFO - Using env: {'DISPLAY': ':0', 05:37:10 INFO - 'HOME': '/home/cltbld', 05:37:10 INFO - 'LANG': 'en_US.UTF-8', 05:37:10 INFO - 'LANGUAGE': 'en_US:en', 05:37:10 INFO - 'LOGNAME': 'cltbld', 05:37:10 INFO - 'MAIL': '/var/mail/cltbld', 05:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:10 INFO - 'MOZ_NO_REMOTE': '1', 05:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:10 INFO - 'NO_EM_RESTART': '1', 05:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:10 INFO - 'PWD': '/builds/slave/test', 05:37:10 INFO - 'SHELL': '/bin/bash', 05:37:10 INFO - 'SHLVL': '1', 05:37:10 INFO - 'TERM': 'linux', 05:37:10 INFO - 'TMOUT': '86400', 05:37:10 INFO - 'USER': 'cltbld', 05:37:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:10 INFO - '_': '/tools/buildbot/bin/python'} 05:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:11 INFO - Downloading/unpacking flake8 05:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:37:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:37: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:37: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:37: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:37: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:37: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:37: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:37:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:37:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:37: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:37: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:37: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:37: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:37: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:37: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:37:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:37: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:37: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:37: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:37: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:37: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:37: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:37:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:37:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:37:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:37:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:37:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:37:13 INFO - no previously-included directories found matching 'docs/_build' 05:37:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:37:13 INFO - Running setup.py install for pep8 05:37:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:37:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:37:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:37:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:37:13 INFO - no previously-included directories found matching 'docs/_build' 05:37:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:37:13 INFO - Cleaning up... 05:37:13 INFO - Return code: 0 05:37:13 INFO - Running post-action listener: _resource_record_post_action 05:37:13 INFO - Running post-action listener: _start_resource_monitoring 05:37:14 INFO - Starting resource monitoring. 05:37:14 INFO - ##### 05:37:14 INFO - ##### Finished create-virtualenv step (success) 05:37:14 INFO - ##### 05:37:14 INFO - ##### 05:37:14 INFO - ##### Running install step. 05:37:14 INFO - ##### 05:37:14 INFO - Running pre-action listener: _resource_record_pre_action 05:37:14 INFO - Running main action method: install 05:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:14 INFO - Reading from file tmpfile_stdout 05:37:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:37:14 INFO - Reading from file tmpfile_stdout 05:37:14 INFO - Output received: 05:37:14 INFO - Usage: mozinstall [options] installer 05:37:14 INFO - Options: 05:37:14 INFO - -h, --help show this help message and exit 05:37:14 INFO - -d DEST, --destination=DEST 05:37:14 INFO - Directory to install application into. [default: 05:37:14 INFO - "/builds/slave/test"] 05:37:14 INFO - --app=APP Application being installed. [default: firefox] 05:37:14 INFO - mkdir: /builds/slave/test/build/application 05:37:14 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:37:14 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:37:31 INFO - Reading from file tmpfile_stdout 05:37:31 INFO - Output received: 05:37:31 INFO - /builds/slave/test/build/application/firefox/firefox 05:37:31 INFO - Running post-action listener: _resource_record_post_action 05:37:31 INFO - ##### 05:37:31 INFO - ##### Finished install step (success) 05:37:31 INFO - ##### 05:37:31 INFO - ##### 05:37:31 INFO - ##### Running run-tests step. 05:37:31 INFO - ##### 05:37:31 INFO - Running pre-action listener: _resource_record_pre_action 05:37:31 INFO - Running main action method: run_tests 05:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:37:31 INFO - Python 2.7.3 05:37:31 INFO - Return code: 0 05:37:31 INFO - grabbing minidump binary from tooltool 05:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1456110>, '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 0x13c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c26c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:37:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:37:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:37:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:37:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:31 INFO - Return code: 0 05:37:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:37:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:37:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:37:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:37:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:37:32 INFO - Return code: 0 05:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:37:32 INFO - Using env: {'DISPLAY': ':0', 05:37:32 INFO - 'HOME': '/home/cltbld', 05:37:32 INFO - 'LANG': 'en_US.UTF-8', 05:37:32 INFO - 'LANGUAGE': 'en_US:en', 05:37:32 INFO - 'LOGNAME': 'cltbld', 05:37:32 INFO - 'MAIL': '/var/mail/cltbld', 05:37:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:32 INFO - 'MOZ_NO_REMOTE': '1', 05:37:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:32 INFO - 'NO_EM_RESTART': '1', 05:37:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:32 INFO - 'PWD': '/builds/slave/test', 05:37:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:32 INFO - 'SHELL': '/bin/bash', 05:37:32 INFO - 'SHLVL': '1', 05:37:32 INFO - 'TERM': 'linux', 05:37:32 INFO - 'TMOUT': '86400', 05:37:32 INFO - 'USER': 'cltbld', 05:37:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162', 05:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:32 INFO - '_': '/tools/buildbot/bin/python'} 05:37:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:37:32 INFO - mozversion application_buildid: 20160614030210 05:37:32 INFO - mozversion application_changeset: ddb6b30149221f00eb5dd180530e9033093d4c2b 05:37:32 INFO - mozversion application_display_name: Nightly 05:37:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:32 INFO - mozversion application_name: Firefox 05:37:32 INFO - mozversion application_remotingname: firefox 05:37:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:37:32 INFO - mozversion application_vendor: Mozilla 05:37:32 INFO - mozversion application_version: 50.0a1 05:37:32 INFO - mozversion platform_buildid: 20160614030210 05:37:32 INFO - mozversion platform_changeset: ddb6b30149221f00eb5dd180530e9033093d4c2b 05:37:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:37:32 INFO - mozversion platform_version: 50.0a1 05:37:32 INFO - using testdate: 1465907852 05:37:32 INFO - actual date: 1465907852 05:37:32 INFO - starting webserver on 'localhost:48625' 05:37:32 INFO - SUITE-START | Running 2 tests 05:37:32 INFO - TEST-START | dromaeo_css 05:37:32 INFO - operating with platform_type : linux_ 05:37:32 INFO - Initialising browser for dromaeo_css test... 05:37:32 INFO - TEST-INFO | started process 24283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9XIMjJ/profile http://localhost:48625/getInfo.html) 05:37:36 INFO - PROCESS | 24283 | __metrics Screen width/height:1600/1200 05:37:36 INFO - PROCESS | 24283 | colorDepth:24 05:37:36 INFO - PROCESS | 24283 | Browser inner width/height: 1024/697 05:37:36 INFO - PROCESS | 24283 | __metrics 05:37:37 INFO - PROCESS | 24283 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:37:37 INFO - PROCESS | 24283 | console.error: PushService: 05:37:37 INFO - PROCESS | 24283 | stateChangeProcessEnqueue: Error transitioning state 05:37:37 INFO - PROCESS | 24283 | UnknownError 05:37:39 INFO - TEST-INFO | 24283: exit 0 05:37:39 INFO - Browser initialized. 05:37:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:39 INFO - TEST-INFO | started process 24363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9XIMjJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:51 INFO - PROCESS | 24363 | RSS: Main: 173305856 05:37:51 INFO - PROCESS | 24363 | 05:38:42 INFO - PROCESS | 24363 | 1465907922467 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:40:50 INFO - PROCESS | 24363 | Cycle 1(1): loaded http://localhost:48625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48625/tests/dromaeo/cssquery-ext.html) 05:40:51 INFO - PROCESS | 24363 | RSS: Main: 271429632 05:40:51 INFO - PROCESS | 24363 | 05:43:53 INFO - PROCESS | 24363 | Cycle 1(1): loaded http://localhost:48625/tests/dromaeo/cssquery-ext.html (next: http://localhost:48625/tests/dromaeo/cssquery-jquery.html) 05:43:54 INFO - PROCESS | 24363 | RSS: Main: 253026304 05:43:54 INFO - PROCESS | 24363 | 05:46:56 INFO - PROCESS | 24363 | Cycle 1(1): loaded http://localhost:48625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48625/tests/dromaeo/cssquery-mootools.html) 05:46:57 INFO - PROCESS | 24363 | RSS: Main: 259584000 05:46:57 INFO - PROCESS | 24363 | 05:49:59 INFO - PROCESS | 24363 | Cycle 1(1): loaded http://localhost:48625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48625/tests/dromaeo/cssquery-prototype.html) 05:49:59 INFO - PROCESS | 24363 | RSS: Main: 251645952 05:49:59 INFO - PROCESS | 24363 | 05:53:02 INFO - PROCESS | 24363 | Cycle 1(1): loaded http://localhost:48625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48625/tests/dromaeo/cssquery-yui.html) 05:53:03 INFO - PROCESS | 24363 | RSS: Main: 218722304 05:53:03 INFO - PROCESS | 24363 | 05:56:05 INFO - PROCESS | 24363 | Cycle 1(1): loaded http://localhost:48625/tests/dromaeo/cssquery-yui.html (next: http://localhost:48625/tests/dromaeo/cssquery-dojo.html) 05:56:05 INFO - PROCESS | 24363 | RSS: Main: 294563840 05:56:05 INFO - PROCESS | 24363 | 05:56:05 INFO - PROCESS | 24363 | __start_tp_report 05:56:05 INFO - PROCESS | 24363 | _x_x_mozilla_page_load 05:56:05 INFO - PROCESS | 24363 | _x_x_mozilla_page_load_details 05:56:05 INFO - PROCESS | 24363 | |i|pagename|runs| 05:56:05 INFO - PROCESS | 24363 | |0;dojo.html;3060.3420264643096;3062.5406189071637;3084.7377972872314;3102.9915277534806;3115.937681246375;5192.091384007803;5242.816501422446;5273.129933560967;5321.3348331458565;5352.785888564457;5210.062188806013;5224.686518808874;5232.398274198468;5252.185911183773;5297.841064768063;4720.386349774524;4756.28655701644;4894.681845680019;4962.032403681265;4978.950210497903;4949.653524253304;4966.404031516205;4979.352684151056;4979.576735977446;4997.15048441764;4740;4753.16819556578;4782.928256076161;4814.470408255089;4903.68126071806;4797.496262892381;4797.976010119927;4815.566599006106;4816.638752093607;4847.079054979577;4728.66899317048;4767.418646436436;4779.283107533863;4783.521647835223;4835.516448355136;5267.710275934822;5332.600054995891;5384.703841288728;5421.457854214586;5432.972835135839;5730.914036289459;5737.741801618896;5780.450857168562;5782.132680097977;5784.623999440023;5579.8605034874045;5636.971815140898;5832.912506312408;5836.503897168745;5844.006518891799;5316.255724198615;5419.458054194589;5420.810271640474;5424.484673956007;5428.619996600279;5852.678102704307;5876.41235876409;5881.41185881417;5886.411358864165;5892.351841297454;5494.890102198014;5531.3362396511875;5546.77812887488;5668.121441176624;5670.971645141748;5696.715164241771;5737.3688894221605;5750.424957504216;5751.309842818889;5753.079507278815;5633.324001119892;5658.519025882846;5663.1505274208375;5677.943220567741;5678.4037676044245;5489.945100549024;5630.887382252414;5645.915311270334;5687.43125687428;5701.458361455655;4372.781360931941;4373.278409062469;4375.671824613103;4376.168527979674;4406.603405693503;3888.941665875014;3906.2382835347403;3914.0019295079574;3943.507061617298;3968.027833180889;5277.102892508283;5305.045091883498;5328.733563321818;5330.760115794798;5333.946660533423;5690.4025077367105;5724.4561766632105;5725.713714314267;5728.856778580485;5759.107338362561;5372.650777699437;5382.67703937765;5387.218853266333;5390.730463476811;5398.352197736218;4684.297355396649;4745.620350371962;4773.307870358779;4774.331593576902;4787.210110331756;5841.4450627190345;5849.824505264849;5851.1223316502865;5851.444112809277;5859.53123750099;5538.529225015919;5656.43435656431;5666.858328541654;5670.064439367458;5672.262605861211;5770.192173095686;5791.855203619774;5814.5639077068545;5878.764849405976;5925.733341999534;5595.524380427709;5600.635958662674;5602.383737788921;5603.411641777555;5606.775728970795;5516.696581688046;5654.06707893193;5666.631668941505;5704.714764261687;5709.914351284817;5492.917606235989;5535.612507124462;5535.750891209825;5566.721663916869;5569.33168019824;5544.22380866687;5551.611387202857;5555.2778138841695;5556.666600004012;5557.41647127062;5350.277712508761;5363.2759577456545;5478.835634930959;5481.3422389311945;5526.889462210653;5511.889762204813;5618.52242559387;5648.745806438638;5653.971730141488;5656.321241451053;5470.753816078206;5471.699056551769;5473.480019398151;5474.91787623194;5476.315460567429 05:56:05 INFO - PROCESS | 24363 | |1;ext.html;580.2775544447161;604.108939314511;609.4149616368286;621.1769405537664;630.0580631955224;35106.47340289898;43357.13285734288;44026;44215.115697686066;47470.287945680844;45136;45560.772196139056;45811.31283030757;45905.31142032872;45984.080318393695;8059.355251579859;8209;8880.37837351384;9031.187193152615;9032.8645070324;10447.529861156267;10724.14206863449;10728;11064.391458469781;11066.502007409686;10821.945890270537;10922.890771092267;10924.617638382659;10926;10937.234393592451;8106.554139522324;8280.751577452625;8287.8342433151;10804.78390432187;10825.24223304369;10591.523381447852;10658.200634952409;10662.413567253798;10667.093297069681;10667.733306667318;42296.365554516706;42623.786881065396;42758.57241427577;42803.78598107021;42807.35788963168;3380.154961259685;3389.305192435545;3392.5080863274934;3530.91172720684;3609.873654422083;30203.244918876982;33030.834845825615;33044.6695533044;33083;33116.33767324664;4414.249577571821;4473.7986790594505;4475;4638.072385522909;4650.604698600623;326787;326802.02588857606;326851;327334;328481;61650;61785.691071545254;61868.38131618626;62101;62177.51289948351;64455.35544644587;64710;64733.35266647367;64792.676036619516;64845.839645233624;15071.623209419853;15308.617284567976;15311.157886316138;15313.540593782205;15320.693586128215;11395.658130256106;11422.200445968869;11444.713882152846;11452.141089418326;11452.3701196435;18086.127666210155;19310;19439.690028625875;19575.902120489307;19625.411237662895;6901.896471552931;7166.175889772639;7178.497505174588;7200.819979500555;7242.23956484572;842.9620667069996;931.8602209668468;986;1056.3186744549876;1075.876274228458;33534.49698254528;33559.83220083884;33598.83200583982;33612.327753445286;33815.661843381255;1079.7138758229075;1117.8658560972735;1164.318873459019;1191.8331433599303;1271.491403438632;17148.142592870307;17330.220140093727;17389.217485213198;17447.825521744875;17460.214290356966;457715;462784;463055;463135;463319;59152;60607.39392606018;60704;60724.69637651872;60758.39241607616;1257.1137348169518;1358.7690092684268;1370.239517068017;1386.0090035624578;1389.6456403617215;32345.35309293848;34823.65176348305;35026.92109644138;35251.65927830714;35261.29477410386;52486.47513524969;53250.2012469821;53442;53452.46547534475;53485.73257133689;460638;465511;474903;475735;476321;44496.77751611221;44685.776571116934;45228.547714522436;47817.52182478131;49307.50692493029;49957;50242;50947.235791462415;51420;51695;42968;43577.346339804295;43687.56312436835;43701;44081.338779918966;42169.1566168681;42283.577164227965;42450;42942.282308707305;43010.12908838094;41736.79131604323;42472.5752742481;42554.78722606367;43311.35032974571;43543.12913741644;35982;37353.94194597675;38259;38405.6159438402;38944.80527597344;28729.42541149207;29365.706342936297;29461.26346841346;29501;29743.851280743456 05:56:05 INFO - PROCESS | 24363 | |2;jquery.html;397.74345547122107;399.26136647202696;399.2753153027257;400.6574378906035;422.14094318062746;13923.651908702288;16425.342986280535;17642;19133.33033343833;19152.808471915276;14913.32890019949;17634.470965871013;18324.816751832477;18585.163667634955;18591.349302774404;5643.125315576082;5834.824955251349;5838;5844.941550584483;5862.149988251701;4160.916781664365;5723.627964182315;5806.767729290823;6100.572959892809;6561.639109848957;6511.4465270452065;6566.63883486408;6584.539082264243;6609.074729537869;6624.3375662433855;6339.11252424661;6604.240512341046;6619.1395118634755;6623.370779775938;6627.039079333494;5769.1346298055205;5833.212516310286;5846.50304724099;5855.121731740273;5872.442117998783;22542.887285563465;23024.88487557568;23287.301380958597;23292.534149316918;23513.88243058791;2438.6463962725484;2488.5271798358435;2578.793696504275;2668.506326329635;3147.5121356189597;13793.517226897011;14121.435142594284;14223.21772302523;14355.210463424508;14763.852361476462;1834.8532117430573;1866.1042699504178;1867.7478540397008;1896.6491199128068;1926.566522532433;81895.5905220476;82948.58525707394;83251;84426.57786711027;86601.56699216526;10620.946895265628;10678.946605266923;10906.90930906903;10972.945135274273;11073.335599864035;15126.243687815566;15212.847871521364;15216.163111028778;15224.391024359124;15231.771523426936;7518.511296765692;7668.348190403878;7829.843403132019;7875.369970402354;7900.249476299742;6289.371062893765;7323.890141647879;7409.518381305198;7524.360429363456;7532.924670753332;6151.538634602333;6515.446187074152;6539.803805885831;6611.768588099393;6694.464442844561;1915.1764741161435;1997.7103320018516;2003.5191554026928;2014.2647933504165;2016.7680716717766;898.6719847255836;1054.593981317183;1075.8063548561177;1102.20090434436;1136.653320737183;19436.639435239682;19748;20055.29806456767;20194.798052019585;20800.687989680166;1005.8541511480794;1027.7944411117805;1031.185363562777;1055.2349546578823;1096.3202814255212;10905.236633435583;11480.425978701198;11526.59656912004;11539.653810385702;11541.884581154249;411267;417055;432839;433410;434867;93296.53351733333;93857;94953.5252323734;95285;96913.5154324238;1003.4581326083833;1028.4189432970347;1034.943078130695;1036.8030074285862;1041.630221271453;17504.649907002044;17602.735958960882;17783.911080444515;17921.19354629071;18385.54036149107;39396;40334;41657.79171104125;41859.581404186785;43089.78455107704;56871;57670.42329576651;59180.40819591749;60683;60914.390856090875;8213.95893020531;8347;8437.493750374997;8504.957475212585;8523.701670441505;9443.858342124737;13366.866331336561;13440.529581464602;13715.245661488314;13816.447342106605;11640;11681.123915706186;11720.824187637021;11789.469473873867;11872.228305160137;11240.887591123985;11310.4910279036;11642.825357619811;11655.125865560287;11865.940670296593;11682.47428865686;11717.824232636347;11978.64064078079;12223.69440763988;12340.197887137307;8553.272971797218;8587.65649374018;8589.098144694717;8685.652573896974;8727.301815854844;9024.86462703073;11498.195126341076;11935;12134.150609457252;12230.205036672587 05:56:05 INFO - PROCESS | 24363 | |3;mootools.html;1324.6489680234745;1481.5036962617523;1522.5584580471664;1647.2834317072075;1785.3305010621018;8564.443311184776;8953.23897468716;9041;9311.58097885595;9324.720258392259;9147.405418647782;9344.81310373792;9352.485613291283;9369.625214991393;9370.156685898268;2148.8388370872167;2220.2340192633515;2368.7394386617457;2422.660827484149;2452;2447.889844956981;2464.223769512607;2464.3223113643803;2466.6300054991716;2468.0374653885;2414.5895197816412;2469.76537228963;2474.5916923707655;2476.2942561370014;2478.033566908898;2084.9687254691266;2316.1082983051647;2384.940376490584;2386.9283921482383;2393.270052633946;2379.3218932604123;2419.951600967971;2438.2197696737053;2439.097533912446;2441.6825812644242;9327.347085704003;9378.812423751555;9460.148586627236;9473.90526094744;9474.336796424253;5092.439831618519;5220.686758794484;5226.477352264781;5228.032813929397;5230.581553475713;3550.4664211556824;3563.322968635977;3592.479090531858;3622.4023036198996;3711.0907827582146;1109.6948339206701;1134.7843909657138;1143.0683992546049;1167.2412931594447;1186.371223251678;13045.804312935219;13065.150765200231;13071.803922941164;13082.084254102218;13136.60590182296;4685.220784991845;4763.8332658357485;4817.638677099231;4832.033593281288;4844.079624871263;11064.668059958214;11123;11126.888731112747;11131.220814543067;11134.276272042453;5265.183896496049;5270;5271.683698978073;5273.024490469275;5276.287701160371;4286.271333873249;4650.441946966385;4774.498677638798;4783;4849.442314133849;4138.958610413918;4171.707980441401;4207.074443622399;4248.214080395137;4254.042840360894;1243.7015116372006;1263.216805580546;1269.2955409747494;1269.6254604891578;1292.6251387097825;999.8050380175941;1004.3471743366724;1018.149844879519;1033.106362996018;1034.8913364096811;6494.545381823322;6604.075429439882;6625.370589794058;6638.070670106189;6701;440.53523532673336;442.5640743867288;443.6716829546177;451.0325352119685;458.8233530090872;4216.494020717533;4354.695171337976;4358.280883654162;4370.497392799869;4456.665750068758;10972.835407468894;11293.15301352402;11640.243384180001;11709.765804683859;11723.765524689628;11326;11546.94226528862;11674.357910315015;11676.124290678234;11704.648860534198;8499.95750021246;8676.826463470696;8688.565571721389;8690.565471726262;8696.086910874266;6332.841678958063;6480.967595161994;6633.9668301658185;6637.734490620321;6692.56109936366;10639.14886809069;10642.574297028032;10776.084032856981;10790.838137428102;10824.188185885932;10693.786124277627;10805.675829725122;10843.512041957973;10945.945270273598;10946.616868409568;7500.587467689329;8142.8778568322705;8281.420300578902;8368.163183681583;8439.409241353047;9395.107464790834;9403.952980235328;9422.62309507612;9462.810743784948;9478.72037274959;8068.47554908929;8300.54347010896;8323.292520135856;8424.789380265542;8457.957710211409;8114.350851931949;8127.878081828659;8189.058258300133;8295.170482951657;8398.706045288385;6937.861242775015;7083.893741593984;7093.113360829896;7096.361327480551;7650.885236721342;5363.0882749931825;5367.570594352364;5370.382406023357;5436.456354364532;5729.312482502127;5474.343078830566;5496.31296087989;5568.805091821929;5580.665160090408;5670.574706896917 05:56:05 INFO - PROCESS | 24363 | |4;prototype.html;316.8494964891677;321.4054000099814;322.51300536190354;330.1959728062168;330.20256081563025;5296.894062118756;5337.332833395825;5340.866478338039;5344.8241386894915;5367.543758780504;5148.433672296044;5230.320058392404;5233.069481090592;5240.580753539717;5258.790478190019;4078.5105787305565;4162.916741665165;4173.707840451169;4204.810783514734;4214.346776249671;4157.023099571598;4166.64583510402;4169.478815148106;4177.95551112222;4194.7415775267455;4074.3684728867074;4147.67274472169;4157.792110394468;4160.251154792136;4173.520045194796;3960.7623542587535;4016.5581786003518;4126.958730412687;4147.3410635745795;4180.832766689329;3655.597884232732;3667.2665466906724;3673.2653469306247;3680.3743363628246;3683.631636836322;5127.564157046656;5134.358205224347;5141;5146.897062058775;5150.536451719326;4572.291294849304;4610.124076425468;4707.340972263886;4742.383490146259;4748.3114948332295;5432.891342173174;5437;5498.752556134984;5508.779648814043;5517.834464966058;4070.2470043041835;4087.080406908422;4087.1008378156757;4110.671146308288;4111.71218014739;5623.325200975868;5665.206871038058;5681.409205422529;5687;5742.36342642345;4113.321301985199;4121.814518346621;4137.275976704064;4144.254034273799;4149.730267532661;4197.97901010493;4220.78896055196;4221.894452638647;4225.619694227473;4227.852025179104;4587.7074876911165;4728.834490792806;4755.548222918817;4756.548127927841;4790.640701947368;5506.531944784738;5509.256250406143;5532.585056120726;5546.168074788733;5560.165975103686;1434.763264061418;1437.7915202295817;1442.5167568864547;1443.4298452111357;1451.528253317676;924.242121460396;937.723371605378;941.4022095969109;948.5446985447024;958.7075941837667;4713.316569097462;4737.739424331695;4739.454962679267;4770.022145460172;4791.281307803857;4974.477679843637;4981.476944920803;4998.900021999612;5044.54599086084;5069.923951140736;4496.24646387909;4747.786349614275;4758.857234282977;4775.498572649822;4788.808447662124;2918.270432391902;2924.8098873573576;2975.41979314036;2991.9401611968074;3033.4843076677016;5755.3381361143165;5763.94236057634;5785.190073389729;5802.390748971297;5871.94128058714;5509.944900550943;5749.137629355547;5771.509421699118;5784.942150578525;5843.415658434207;5845.678487683133;5855.853603659857;5883.970580147072;5889.146073819358;5905.409459054146;5483.8080667176455;5602.89891290766;5628.4090170533145;5715.599908006399;5733.913991290217;5570.275864137636;5578.219049333178;5580.693061881636;5588.211772232847;5600.635958662837;5771.066692658007;5800.4489573490455;5807.448292412214;5809.00836069433;5811.27359080115;4004.798560431917;4096.16028714107;4104;4108.2810508160355;4140.482439695038;5570.693611851387;5623.915641265303;5624.775008999758;5638.605297629127;5670.886582268414;5458.580769000168;5477.835664930059;5498.147787093007;5508.980838544882;5510.996506903667;5237;5508.614396992172;5509.724513774215;5516.862078447911;5546.611737178358;5421.918671219856;5456.017916775018;5456.345238571397;5462.426445223195;5470.8085217017215;5501.312335958005;5556.749946252347;5570.5543556516195;5579.298314014264;5594.664320140804;5222.97388513055;5472.616916815944;5514.172874068921;5515.917261241005;5530.364008139116 05:56:05 INFO - PROCESS | 24363 | |5;yui.html;751.8345963887946;758.8254701418678;790.1900551934267;798.92410221029;812.9349652027838;15176.772348414783;15827.52517424479;15850.76223856643;15857.3657053718;15871.920640396811;15361.692766144699;15427.151506667129;15468.767968480453;15582.376704931788;15615.609609759733;665.6838001949084;774.8682723936917;775.8409526047161;795.9880601790978;798.0543056478064;792.0772300270207;795.7334293011847;800.7037396163428;802.6709049289792;803.7869964459394;862.1335557764438;865.2558799432483;872.7687162901836;873.057098333798;874.1564390363299;712.8503014366989;852.5055467828676;857.0187135729554;859.77645812089;861.1001503428901;605.6578033411108;619.3434958943534;620.2092332276338;621.266905052043;621.7668374359615;14183.858161418357;14343.56969290923;14355.856441435557;14360.712785744332;14364.784528232085;13210.339483025906;13982.300884955814;13991.160530368108;14030.649233769136;14090.577282681536;10900.890991090067;12018.579349722717;12151.608154302932;12326;12563.434645440977;4309.806058727333;4369.3227549729845;4377.25586650267;4444.025706125041;4448.154850578379;78831.60584197042;79158.20841791567;79740.20259797385;80982.99999999942;81605.18394816035;10960.342379457257;10964.616238431776;11092.667219983414;11171.776564468664;11274.661760147208;21303.14787408486;21337.573248534944;21360;21366.465838353855;21378.679319810217;8356;8520.233179013918;8538.530380829114;8718.86921696175;8721.91278087211;4367.410399596078;4462.152191083748;4517.5482451755215;4529.297958816389;4535.183666939983;3514.4201206801104;3669.94495082574;3670.6512881276235;3671.2473942841652;3673;610.1975901689265;614.2230078950132;617.043582447205;626.9028300613412;628.8773689130667;585.859393745498;589.4724221821446;643.9710213040424;666.5001249063203;696.8954207581041;8640.956795215983;8699.304055675531;8725.389222754473;9094;9098.999110097884;498.40758775711976;536.1876756713582;559.767696405987;568.4486048532916;614.3549273263056;4346.239408103569;4395.648348132142;4400.801963911632;4482.193205223091;4557.339185818038;115081;118931.40534297447;120593.39703301428;121058.39470802766;124247.3787631056;79906;98324.50837745765;99670;101092;101398.49300753449;92142;93098.53450732703;94889.52555237318;95377;96387.03612963921;8506.362022848187;8532.189442003;8539.402241843012;8593.226609605166;8609.311255099703;53967;54787.45212547824;55824;56020.439795601524;57483.137752932904;77178;79671.80676173973;79737.60131199307;81786;82214.17785822065;11069.944650276697;11718.355490448108;12059.457324420599;12168.2699038058;12973.740525189633;11541.307521548733;11668.649940501798;11684.240524365889;11900.821487677518;12071.275723456269;11350.545978161112;11436.313821170756;11637.88362116368;11648.35934023603;11962.342071186169;11440.427978601203;11519.678253375572;11539.88164735673;11644.88355116472;11677.591284305008;10500.212484063573;10617.787644247226;10845.240833141605;10883.074938630305;11374.488148033193;9279.72160835176;9318.580663870007;9350.438973661601;9661.372010819556;9670.75823104428;9180;9476.431414115175;9507.66723164686;9544.95227523858;9714.562844671866 05:56:05 INFO - PROCESS | 24363 | __end_tp_report 05:56:05 INFO - PROCESS | 24363 | __start_cc_report 05:56:05 INFO - PROCESS | 24363 | _x_x_mozilla_cycle_collect,802 05:56:05 INFO - PROCESS | 24363 | __end_cc_report 05:56:05 INFO - PROCESS | 24363 | __startTimestamp1465908965982__endTimestamp 05:56:05 INFO - PROCESS | 24363 | 05:56:05 INFO - PROCESS | 24363 | ------- Summary: start ------- 05:56:05 INFO - PROCESS | 24363 | Number of tests: 6 05:56:05 INFO - PROCESS | 24363 | 05:56:05 INFO - PROCESS | 24363 | [#0] dojo.html Cycles:165 Average:5281.66 Median:5478.84 stddev:597.80 (10.9%) stddev-sans-first:573.68 05:56:05 INFO - PROCESS | 24363 | Values: 3060.3 3062.5 3084.7 3103.0 3115.9 5192.1 5242.8 5273.1 5321.3 5352.8 5210.1 5224.7 5232.4 5252.2 5297.8 4720.4 4756.3 4894.7 4962.0 4979.0 4949.7 4966.4 4979.4 4979.6 4997.2 4740.0 4753.2 4782.9 4814.5 4903.7 4797.5 4798.0 4815.6 4816.6 4847.1 4728.7 4767.4 4779.3 4783.5 4835.5 5267.7 5332.6 5384.7 5421.5 5433.0 5730.9 5737.7 5780.5 5782.1 5784.6 5579.9 5637.0 5832.9 5836.5 5844.0 5316.3 5419.5 5420.8 5424.5 5428.6 5852.7 5876.4 5881.4 5886.4 5892.4 5494.9 5531.3 5546.8 5668.1 5671.0 5696.7 5737.4 5750.4 5751.3 5753.1 5633.3 5658.5 5663.2 5677.9 5678.4 5489.9 5630.9 5645.9 5687.4 5701.5 4372.8 4373.3 4375.7 4376.2 4406.6 3888.9 3906.2 3914.0 3943.5 3968.0 5277.1 5305.0 5328.7 5330.8 5333.9 5690.4 5724.5 5725.7 5728.9 5759.1 5372.7 5382.7 5387.2 5390.7 5398.4 4684.3 4745.6 4773.3 4774.3 4787.2 5841.4 5849.8 5851.1 5851.4 5859.5 5538.5 5656.4 5666.9 5670.1 5672.3 5770.2 5791.9 5814.6 5878.8 5925.7 5595.5 5600.6 5602.4 5603.4 5606.8 5516.7 5654.1 5666.6 5704.7 5709.9 5492.9 5535.6 5535.8 5566.7 5569.3 5544.2 5551.6 5555.3 5556.7 5557.4 5350.3 5363.3 5478.8 5481.3 5526.9 5511.9 5618.5 5648.7 5654.0 5656.3 5470.8 5471.7 5473.5 5474.9 5476.3 05:56:05 INFO - PROCESS | 24363 | 05:56:05 INFO - PROCESS | 24363 | [#1] ext.html Cycles:180 Average:59942.00 Median:42513.68 stddev:112184.96 (263.9%) stddev-sans-first:112411.13 05:56:05 INFO - PROCESS | 24363 | Values: 580.3 604.1 609.4 621.2 630.1 35106.5 43357.1 44026.0 44215.1 47470.3 45136.0 45560.8 45811.3 45905.3 45984.1 8059.4 8209.0 8880.4 9031.2 9032.9 10447.5 10724.1 10728.0 11064.4 11066.5 10821.9 10922.9 10924.6 10926.0 10937.2 8106.6 8280.8 8287.8 10804.8 10825.2 10591.5 10658.2 10662.4 10667.1 10667.7 42296.4 42623.8 42758.6 42803.8 42807.4 3380.2 3389.3 3392.5 3530.9 3609.9 30203.2 33030.8 33044.7 33083.0 33116.3 4414.2 4473.8 4475.0 4638.1 4650.6 326787.0 326802.0 326851.0 327334.0 328481.0 61650.0 61785.7 61868.4 62101.0 62177.5 64455.4 64710.0 64733.4 64792.7 64845.8 15071.6 15308.6 15311.2 15313.5 15320.7 11395.7 11422.2 11444.7 11452.1 11452.4 18086.1 19310.0 19439.7 19575.9 19625.4 6901.9 7166.2 7178.5 7200.8 7242.2 843.0 931.9 986.0 1056.3 1075.9 33534.5 33559.8 33598.8 33612.3 33815.7 1079.7 1117.9 1164.3 1191.8 1271.5 17148.1 17330.2 17389.2 17447.8 17460.2 457715.0 462784.0 463055.0 463135.0 463319.0 59152.0 60607.4 60704.0 60724.7 60758.4 1257.1 1358.8 1370.2 1386.0 1389.6 32345.4 34823.7 35026.9 35251.7 35261.3 52486.5 53250.2 53442.0 53452.5 53485.7 460638.0 465511.0 474903.0 475735.0 476321.0 44496.8 44685.8 45228.5 47817.5 49307.5 49957.0 50242.0 50947.2 51420.0 51695.0 42968.0 43577.3 43687.6 43701.0 44081.3 42169.2 42283.6 42450.0 42942.3 43010.1 41736.8 42472.6 42554.8 43311.4 43543.1 35982.0 37353.9 38259.0 38405.6 38944.8 28729.4 29365.7 29461.3 29501.0 29743.9 05:56:05 INFO - PROCESS | 24363 | 05:56:05 INFO - PROCESS | 24363 | [#2] jquery.html Cycles:180 Average:27525.30 Median:23403.21 stddev:70748.79 (302.3%) stddev-sans-first:70917.94 05:56:05 INFO - PROCESS | 24363 | Values: 397.7 399.3 399.3 400.7 422.1 13923.7 16425.3 17642.0 19133.3 19152.8 14913.3 17634.5 18324.8 18585.2 18591.3 5643.1 5834.8 5838.0 5844.9 5862.1 4160.9 5723.6 5806.8 6100.6 6561.6 6511.4 6566.6 6584.5 6609.1 6624.3 6339.1 6604.2 6619.1 6623.4 6627.0 5769.1 5833.2 5846.5 5855.1 5872.4 22542.9 23024.9 23287.3 23292.5 23513.9 2438.6 2488.5 2578.8 2668.5 3147.5 13793.5 14121.4 14223.2 14355.2 14763.9 1834.9 1866.1 1867.7 1896.6 1926.6 81895.6 82948.6 83251.0 84426.6 86601.6 10620.9 10678.9 10906.9 10972.9 11073.3 15126.2 15212.8 15216.2 15224.4 15231.8 7518.5 7668.3 7829.8 7875.4 7900.2 6289.4 7323.9 7409.5 7524.4 7532.9 6151.5 6515.4 6539.8 6611.8 6694.5 1915.2 1997.7 2003.5 2014.3 2016.8 898.7 1054.6 1075.8 1102.2 1136.7 19436.6 19748.0 20055.3 20194.8 20800.7 1005.9 1027.8 1031.2 1055.2 1096.3 10905.2 11480.4 11526.6 11539.7 11541.9 411267.0 417055.0 432839.0 433410.0 434867.0 93296.5 93857.0 94953.5 95285.0 96913.5 1003.5 1028.4 1034.9 1036.8 1041.6 17504.6 17602.7 17783.9 17921.2 18385.5 39396.0 40334.0 41657.8 41859.6 43089.8 56871.0 57670.4 59180.4 60683.0 60914.4 8214.0 8347.0 8437.5 8505.0 8523.7 9443.9 13366.9 13440.5 13715.2 13816.4 11640.0 11681.1 11720.8 11789.5 11872.2 11240.9 11310.5 11642.8 11655.1 11865.9 11682.5 11717.8 11978.6 12223.7 12340.2 8553.3 8587.7 8589.1 8685.7 8727.3 9024.9 11498.2 11935.0 12134.2 12230.2 05:56:05 INFO - PROCESS | 24363 | 05:56:05 INFO - PROCESS | 24363 | [#3] mootools.html Cycles:180 Average:6117.82 Median:443.12 stddev:3561.14 (803.7%) stddev-sans-first:3552.92 05:56:05 INFO - PROCESS | 24363 | Values: 1324.6 1481.5 1522.6 1647.3 1785.3 8564.4 8953.2 9041.0 9311.6 9324.7 9147.4 9344.8 9352.5 9369.6 9370.2 2148.8 2220.2 2368.7 2422.7 2452.0 2447.9 2464.2 2464.3 2466.6 2468.0 2414.6 2469.8 2474.6 2476.3 2478.0 2085.0 2316.1 2384.9 2386.9 2393.3 2379.3 2420.0 2438.2 2439.1 2441.7 9327.3 9378.8 9460.1 9473.9 9474.3 5092.4 5220.7 5226.5 5228.0 5230.6 3550.5 3563.3 3592.5 3622.4 3711.1 1109.7 1134.8 1143.1 1167.2 1186.4 13045.8 13065.2 13071.8 13082.1 13136.6 4685.2 4763.8 4817.6 4832.0 4844.1 11064.7 11123.0 11126.9 11131.2 11134.3 5265.2 5270.0 5271.7 5273.0 5276.3 4286.3 4650.4 4774.5 4783.0 4849.4 4139.0 4171.7 4207.1 4248.2 4254.0 1243.7 1263.2 1269.3 1269.6 1292.6 999.8 1004.3 1018.1 1033.1 1034.9 6494.5 6604.1 6625.4 6638.1 6701.0 440.5 442.6 443.7 451.0 458.8 4216.5 4354.7 4358.3 4370.5 4456.7 10972.8 11293.2 11640.2 11709.8 11723.8 11326.0 11546.9 11674.4 11676.1 11704.6 8500.0 8676.8 8688.6 8690.6 8696.1 6332.8 6481.0 6634.0 6637.7 6692.6 10639.1 10642.6 10776.1 10790.8 10824.2 10693.8 10805.7 10843.5 10945.9 10946.6 7500.6 8142.9 8281.4 8368.2 8439.4 9395.1 9404.0 9422.6 9462.8 9478.7 8068.5 8300.5 8323.3 8424.8 8458.0 8114.4 8127.9 8189.1 8295.2 8398.7 6937.9 7083.9 7093.1 7096.4 7650.9 5363.1 5367.6 5370.4 5436.5 5729.3 5474.3 5496.3 5568.8 5580.7 5670.6 05:56:05 INFO - PROCESS | 24363 | 05:56:05 INFO - PROCESS | 24363 | [#4] prototype.html Cycles:180 Average:4616.32 Median:5186.76 stddev:1337.10 (25.8%) stddev-sans-first:1301.32 05:56:05 INFO - PROCESS | 24363 | Values: 316.8 321.4 322.5 330.2 330.2 5296.9 5337.3 5340.9 5344.8 5367.5 5148.4 5230.3 5233.1 5240.6 5258.8 4078.5 4162.9 4173.7 4204.8 4214.3 4157.0 4166.6 4169.5 4178.0 4194.7 4074.4 4147.7 4157.8 4160.3 4173.5 3960.8 4016.6 4127.0 4147.3 4180.8 3655.6 3667.3 3673.3 3680.4 3683.6 5127.6 5134.4 5141.0 5146.9 5150.5 4572.3 4610.1 4707.3 4742.4 4748.3 5432.9 5437.0 5498.8 5508.8 5517.8 4070.2 4087.1 4087.1 4110.7 4111.7 5623.3 5665.2 5681.4 5687.0 5742.4 4113.3 4121.8 4137.3 4144.3 4149.7 4198.0 4220.8 4221.9 4225.6 4227.9 4587.7 4728.8 4755.5 4756.5 4790.6 5506.5 5509.3 5532.6 5546.2 5560.2 1434.8 1437.8 1442.5 1443.4 1451.5 924.2 937.7 941.4 948.5 958.7 4713.3 4737.7 4739.5 4770.0 4791.3 4974.5 4981.5 4998.9 5044.5 5069.9 4496.2 4747.8 4758.9 4775.5 4788.8 2918.3 2924.8 2975.4 2991.9 3033.5 5755.3 5763.9 5785.2 5802.4 5871.9 5509.9 5749.1 5771.5 5784.9 5843.4 5845.7 5855.9 5884.0 5889.1 5905.4 5483.8 5602.9 5628.4 5715.6 5733.9 5570.3 5578.2 5580.7 5588.2 5600.6 5771.1 5800.4 5807.4 5809.0 5811.3 4004.8 4096.2 4104.0 4108.3 4140.5 5570.7 5623.9 5624.8 5638.6 5670.9 5458.6 5477.8 5498.1 5509.0 5511.0 5237.0 5508.6 5509.7 5516.9 5546.6 5421.9 5456.0 5456.3 5462.4 5470.8 5501.3 5556.7 5570.6 5579.3 5594.7 5223.0 5472.6 5514.2 5515.9 5530.4 05:56:05 INFO - PROCESS | 24363 | 05:56:05 INFO - PROCESS | 24363 | [#5] yui.html Cycles:180 Average:21005.21 Median:55305.73 stddev:31452.00 (56.9%) stddev-sans-first:31503.46 05:56:05 INFO - PROCESS | 24363 | Values: 751.8 758.8 790.2 798.9 812.9 15176.8 15827.5 15850.8 15857.4 15871.9 15361.7 15427.2 15468.8 15582.4 15615.6 665.7 774.9 775.8 796.0 798.1 792.1 795.7 800.7 802.7 803.8 862.1 865.3 872.8 873.1 874.2 712.9 852.5 857.0 859.8 861.1 605.7 619.3 620.2 621.3 621.8 14183.9 14343.6 14355.9 14360.7 14364.8 13210.3 13982.3 13991.2 14030.6 14090.6 10900.9 12018.6 12151.6 12326.0 12563.4 4309.8 4369.3 4377.3 4444.0 4448.2 78831.6 79158.2 79740.2 80983.0 81605.2 10960.3 10964.6 11092.7 11171.8 11274.7 21303.1 21337.6 21360.0 21366.5 21378.7 8356.0 8520.2 8538.5 8718.9 8721.9 4367.4 4462.2 4517.5 4529.3 4535.2 3514.4 3669.9 3670.7 3671.2 3673.0 610.2 614.2 617.0 626.9 628.9 585.9 589.5 644.0 666.5 696.9 8641.0 8699.3 8725.4 9094.0 9099.0 498.4 536.2 559.8 568.4 614.4 4346.2 4395.6 4400.8 4482.2 4557.3 115081.0 118931.4 120593.4 121058.4 124247.4 79906.0 98324.5 99670.0 101092.0 101398.5 92142.0 93098.5 94889.5 95377.0 96387.0 8506.4 8532.2 8539.4 8593.2 8609.3 53967.0 54787.5 55824.0 56020.4 57483.1 77178.0 79671.8 79737.6 81786.0 82214.2 11069.9 11718.4 12059.5 12168.3 12973.7 11541.3 11668.6 11684.2 11900.8 12071.3 11350.5 11436.3 11637.9 11648.4 11962.3 11440.4 11519.7 11539.9 11644.9 11677.6 10500.2 10617.8 10845.2 10883.1 11374.5 9279.7 9318.6 9350.4 9661.4 9670.8 9180.0 9476.4 9507.7 9545.0 9714.6 05:56:05 INFO - PROCESS | 24363 | -------- Summary: end -------- 05:56:05 INFO - PROCESS | 24363 | 05:56:06 INFO - TEST-INFO | 24363: exit 0 05:56:06 INFO - TEST-OK | dromaeo_css | took 1114420ms 05:56:06 INFO - TEST-START | kraken 05:56:06 INFO - operating with platform_type : linux_ 05:56:06 INFO - Initialising browser for kraken test... 05:56:06 INFO - TEST-INFO | started process 24542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphCt6S7/profile http://localhost:48625/getInfo.html) 05:56:10 INFO - PROCESS | 24542 | __metrics Screen width/height:1600/1200 05:56:10 INFO - PROCESS | 24542 | colorDepth:24 05:56:10 INFO - PROCESS | 24542 | Browser inner width/height: 1024/697 05:56:10 INFO - PROCESS | 24542 | __metrics 05:56:11 INFO - PROCESS | 24542 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:56:12 INFO - PROCESS | 24542 | console.error: PushService: 05:56:12 INFO - PROCESS | 24542 | stateChangeProcessEnqueue: Error transitioning state 05:56:12 INFO - PROCESS | 24542 | UnknownError 05:56:12 INFO - TEST-INFO | 24542: exit 0 05:56:12 INFO - Browser initialized. 05:56:12 INFO - Running cycle 1/1 for kraken test... 05:56:12 INFO - TEST-INFO | started process 24625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphCt6S7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:24 INFO - PROCESS | 24625 | RSS: Main: 174211072 05:56:24 INFO - PROCESS | 24625 | 05:56:27 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48625/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:28 INFO - PROCESS | 24625 | RSS: Main: 232607744 05:56:28 INFO - PROCESS | 24625 | 05:56:30 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48625/tests/kraken/driver.html?testName=audio-dft) 05:56:31 INFO - PROCESS | 24625 | RSS: Main: 220848128 05:56:31 INFO - PROCESS | 24625 | 05:56:34 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48625/tests/kraken/driver.html?testName=audio-fft) 05:56:35 INFO - PROCESS | 24625 | RSS: Main: 287121408 05:56:35 INFO - PROCESS | 24625 | 05:56:37 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48625/tests/kraken/driver.html?testName=audio-oscillator) 05:56:37 INFO - PROCESS | 24625 | RSS: Main: 197681152 05:56:37 INFO - PROCESS | 24625 | 05:56:40 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:56:40 INFO - PROCESS | 24625 | RSS: Main: 201945088 05:56:40 INFO - PROCESS | 24625 | 05:56:43 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48625/tests/kraken/driver.html?testName=imaging-darkroom) 05:56:44 INFO - PROCESS | 24625 | RSS: Main: 237654016 05:56:44 INFO - PROCESS | 24625 | 05:56:47 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48625/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:48 INFO - PROCESS | 24625 | RSS: Main: 237953024 05:56:48 INFO - PROCESS | 24625 | 05:56:51 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48625/tests/kraken/driver.html?testName=json-parse-financial) 05:56:51 INFO - PROCESS | 24625 | RSS: Main: 238878720 05:56:51 INFO - PROCESS | 24625 | 05:56:53 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:53 INFO - PROCESS | 24625 | RSS: Main: 227225600 05:56:53 INFO - PROCESS | 24625 | 05:56:55 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48625/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:56 INFO - PROCESS | 24625 | RSS: Main: 231854080 05:56:56 INFO - PROCESS | 24625 | 05:56:58 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:59 INFO - PROCESS | 24625 | RSS: Main: 237703168 05:56:59 INFO - PROCESS | 24625 | 05:57:01 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:02 INFO - PROCESS | 24625 | RSS: Main: 241016832 05:57:02 INFO - PROCESS | 24625 | 05:57:04 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:57:05 INFO - PROCESS | 24625 | RSS: Main: 239415296 05:57:05 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | Cycle 1(1): loaded http://localhost:48625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48625/tests/kraken/driver.html?testName=ai-astar) 05:57:07 INFO - PROCESS | 24625 | RSS: Main: 282193920 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | __start_tp_report 05:57:07 INFO - PROCESS | 24625 | _x_x_mozilla_page_load 05:57:07 INFO - PROCESS | 24625 | _x_x_mozilla_page_load_details 05:57:07 INFO - PROCESS | 24625 | |i|pagename|runs| 05:57:07 INFO - PROCESS | 24625 | |0;ai-astar;111;105;110;111;111;111;110;109;111;109 05:57:07 INFO - PROCESS | 24625 | |1;audio-beat-detection;154;136;126;179;131;129;155;132;161;124 05:57:07 INFO - PROCESS | 24625 | |2;audio-dft;162;161;161;160;160;160;160;161;159;161 05:57:07 INFO - PROCESS | 24625 | |3;audio-fft;74;75;78;131;75;75;75;74;98;75 05:57:07 INFO - PROCESS | 24625 | |4;audio-oscillator;94;84;114;85;86;86;133;85;86;127 05:57:07 INFO - PROCESS | 24625 | |5;imaging-gaussian-blur;116;117;118;117;117;117;117;117;117;117 05:57:07 INFO - PROCESS | 24625 | |6;imaging-darkroom;145;146;146;147;147;147;147;147;146;146 05:57:07 INFO - PROCESS | 24625 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 05:57:07 INFO - PROCESS | 24625 | |8;json-parse-financial;53;53;53;52;55;55;66;54;54;52 05:57:07 INFO - PROCESS | 24625 | |9;json-stringify-tinderbox;60;62;63;62;63;61;61;61;62;62 05:57:07 INFO - PROCESS | 24625 | |10;stanford-crypto-aes;79;84;81;79;78;80;80;86;111;87 05:57:07 INFO - PROCESS | 24625 | |11;stanford-crypto-ccm;124;123;130;121;128;128;118;120;126;124 05:57:07 INFO - PROCESS | 24625 | |12;stanford-crypto-pbkdf2;159;161;160;160;162;159;158;157;156;160 05:57:07 INFO - PROCESS | 24625 | |13;stanford-crypto-sha256-iterative;64;67;64;63;65;63;64;63;66;64 05:57:07 INFO - PROCESS | 24625 | __end_tp_report 05:57:07 INFO - PROCESS | 24625 | __start_cc_report 05:57:07 INFO - PROCESS | 24625 | _x_x_mozilla_cycle_collect,1621 05:57:07 INFO - PROCESS | 24625 | __end_cc_report 05:57:07 INFO - PROCESS | 24625 | __startTimestamp1465909027390__endTimestamp 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | ------- Summary: start ------- 05:57:07 INFO - PROCESS | 24625 | Number of tests: 14 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:1.87 (1.7%) stddev-sans-first:1.94 05:57:07 INFO - PROCESS | 24625 | Values: 111.0 105.0 110.0 111.0 111.0 111.0 110.0 109.0 111.0 109.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:145.00 stddev:18.39 (12.7%) stddev-sans-first:19.05 05:57:07 INFO - PROCESS | 24625 | Values: 154.0 136.0 126.0 179.0 131.0 129.0 155.0 132.0 161.0 124.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 05:57:07 INFO - PROCESS | 24625 | Values: 162.0 161.0 161.0 160.0 160.0 160.0 160.0 161.0 159.0 161.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:18.37 (24.5%) stddev-sans-first:19.19 05:57:07 INFO - PROCESS | 24625 | Values: 74.0 75.0 78.0 131.0 75.0 75.0 75.0 74.0 98.0 75.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#4] audio-oscillator Cycles:10 Average:98.00 Median:85.50 stddev:19.16 (22.4%) stddev-sans-first:20.27 05:57:07 INFO - PROCESS | 24625 | Values: 94.0 84.0 114.0 85.0 86.0 86.0 133.0 85.0 86.0 127.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 05:57:07 INFO - PROCESS | 24625 | Values: 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 05:57:07 INFO - PROCESS | 24625 | Values: 145.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:57:07 INFO - PROCESS | 24625 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.00 stddev:4.11 (7.6%) stddev-sans-first:4.31 05:57:07 INFO - PROCESS | 24625 | Values: 53.0 53.0 53.0 52.0 55.0 55.0 66.0 54.0 54.0 52.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.95 (1.5%) stddev-sans-first:0.78 05:57:07 INFO - PROCESS | 24625 | Values: 60.0 62.0 63.0 62.0 63.0 61.0 61.0 61.0 62.0 62.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:80.50 stddev:9.81 (12.2%) stddev-sans-first:10.20 05:57:07 INFO - PROCESS | 24625 | Values: 79.0 84.0 81.0 79.0 78.0 80.0 80.0 86.0 111.0 87.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:125.00 stddev:3.85 (3.1%) stddev-sans-first:4.09 05:57:07 INFO - PROCESS | 24625 | Values: 124.0 123.0 130.0 121.0 128.0 128.0 118.0 120.0 126.0 124.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:160.00 stddev:1.81 (1.1%) stddev-sans-first:1.92 05:57:07 INFO - PROCESS | 24625 | Values: 159.0 161.0 160.0 160.0 162.0 159.0 158.0 157.0 156.0 160.0 05:57:07 INFO - PROCESS | 24625 | 05:57:07 INFO - PROCESS | 24625 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 05:57:07 INFO - PROCESS | 24625 | Values: 64.0 67.0 64.0 63.0 65.0 63.0 64.0 63.0 66.0 64.0 05:57:07 INFO - PROCESS | 24625 | -------- Summary: end -------- 05:57:07 INFO - PROCESS | 24625 | 05:57:08 INFO - TEST-INFO | 24625: exit 0 05:57:08 INFO - TEST-OK | kraken | took 61633ms 05:57:08 INFO - SUITE-END | took 1176s 05:57:08 INFO - Completed test suite (00:19:36) 05:57:08 INFO - javascript benchmark 05:57:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.3420264643096, 3062.5406189071637, 3084.7377972872314, 3102.9915277534806, 3115.937681246375, 5192.091384007803, 5242.816501422446, 5273.129933560967, 5321.3348331458565, 5352.785888564457, 5210.062188806013, 5224.686518808874, 5232.398274198468, 5252.185911183773, 5297.841064768063, 4720.386349774524, 4756.28655701644, 4894.681845680019, 4962.032403681265, 4978.950210497903, 4949.653524253304, 4966.404031516205, 4979.352684151056, 4979.576735977446, 4997.15048441764, 4740.0, 4753.16819556578, 4782.928256076161, 4814.470408255089, 4903.68126071806, 4797.496262892381, 4797.976010119927, 4815.566599006106, 4816.638752093607, 4847.079054979577, 4728.66899317048, 4767.418646436436, 4779.283107533863, 4783.521647835223, 4835.516448355136, 5267.710275934822, 5332.600054995891, 5384.703841288728, 5421.457854214586, 5432.972835135839, 5730.914036289459, 5737.741801618896, 5780.450857168562, 5782.132680097977, 5784.623999440023, 5579.8605034874045, 5636.971815140898, 5832.912506312408, 5836.503897168745, 5844.006518891799, 5316.255724198615, 5419.458054194589, 5420.810271640474, 5424.484673956007, 5428.619996600279, 5852.678102704307, 5876.41235876409, 5881.41185881417, 5886.411358864165, 5892.351841297454, 5494.890102198014, 5531.3362396511875, 5546.77812887488, 5668.121441176624, 5670.971645141748, 5696.715164241771, 5737.3688894221605, 5750.424957504216, 5751.309842818889, 5753.079507278815, 5633.324001119892, 5658.519025882846, 5663.1505274208375, 5677.943220567741, 5678.4037676044245, 5489.945100549024, 5630.887382252414, 5645.915311270334, 5687.43125687428, 5701.458361455655, 4372.781360931941, 4373.278409062469, 4375.671824613103, 4376.168527979674, 4406.603405693503, 3888.941665875014, 3906.2382835347403, 3914.0019295079574, 3943.507061617298, 3968.027833180889, 5277.102892508283, 5305.045091883498, 5328.733563321818, 5330.760115794798, 5333.946660533423, 5690.4025077367105, 5724.4561766632105, 5725.713714314267, 5728.856778580485, 5759.107338362561, 5372.650777699437, 5382.67703937765, 5387.218853266333, 5390.730463476811, 5398.352197736218, 4684.297355396649, 4745.620350371962, 4773.307870358779, 4774.331593576902, 4787.210110331756, 5841.4450627190345, 5849.824505264849, 5851.1223316502865, 5851.444112809277, 5859.53123750099, 5538.529225015919, 5656.43435656431, 5666.858328541654, 5670.064439367458, 5672.262605861211, 5770.192173095686, 5791.855203619774, 5814.5639077068545, 5878.764849405976, 5925.733341999534, 5595.524380427709, 5600.635958662674, 5602.383737788921, 5603.411641777555, 5606.775728970795, 5516.696581688046, 5654.06707893193, 5666.631668941505, 5704.714764261687, 5709.914351284817, 5492.917606235989, 5535.612507124462, 5535.750891209825, 5566.721663916869, 5569.33168019824, 5544.22380866687, 5551.611387202857, 5555.2778138841695, 5556.666600004012, 5557.41647127062, 5350.277712508761, 5363.2759577456545, 5478.835634930959, 5481.3422389311945, 5526.889462210653, 5511.889762204813, 5618.52242559387, 5648.745806438638, 5653.971730141488, 5656.321241451053, 5470.753816078206, 5471.699056551769, 5473.480019398151, 5474.91787623194, 5476.315460567429], "value": 5241.5487430519715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.2775544447161, 604.108939314511, 609.4149616368286, 621.1769405537664, 630.0580631955224, 35106.47340289898, 43357.13285734288, 44026.0, 44215.115697686066, 47470.287945680844, 45136.0, 45560.772196139056, 45811.31283030757, 45905.31142032872, 45984.080318393695, 8059.355251579859, 8209.0, 8880.37837351384, 9031.187193152615, 9032.8645070324, 10447.529861156267, 10724.14206863449, 10728.0, 11064.391458469781, 11066.502007409686, 10821.945890270537, 10922.890771092267, 10924.617638382659, 10926.0, 10937.234393592451, 8106.554139522324, 8280.751577452625, 8287.8342433151, 10804.78390432187, 10825.24223304369, 10591.523381447852, 10658.200634952409, 10662.413567253798, 10667.093297069681, 10667.733306667318, 42296.365554516706, 42623.786881065396, 42758.57241427577, 42803.78598107021, 42807.35788963168, 3380.154961259685, 3389.305192435545, 3392.5080863274934, 3530.91172720684, 3609.873654422083, 30203.244918876982, 33030.834845825615, 33044.6695533044, 33083.0, 33116.33767324664, 4414.249577571821, 4473.7986790594505, 4475.0, 4638.072385522909, 4650.604698600623, 326787.0, 326802.02588857606, 326851.0, 327334.0, 328481.0, 61650.0, 61785.691071545254, 61868.38131618626, 62101.0, 62177.51289948351, 64455.35544644587, 64710.0, 64733.35266647367, 64792.676036619516, 64845.839645233624, 15071.623209419853, 15308.617284567976, 15311.157886316138, 15313.540593782205, 15320.693586128215, 11395.658130256106, 11422.200445968869, 11444.713882152846, 11452.141089418326, 11452.3701196435, 18086.127666210155, 19310.0, 19439.690028625875, 19575.902120489307, 19625.411237662895, 6901.896471552931, 7166.175889772639, 7178.497505174588, 7200.819979500555, 7242.23956484572, 842.9620667069996, 931.8602209668468, 986.0, 1056.3186744549876, 1075.876274228458, 33534.49698254528, 33559.83220083884, 33598.83200583982, 33612.327753445286, 33815.661843381255, 1079.7138758229075, 1117.8658560972735, 1164.318873459019, 1191.8331433599303, 1271.491403438632, 17148.142592870307, 17330.220140093727, 17389.217485213198, 17447.825521744875, 17460.214290356966, 457715.0, 462784.0, 463055.0, 463135.0, 463319.0, 59152.0, 60607.39392606018, 60704.0, 60724.69637651872, 60758.39241607616, 1257.1137348169518, 1358.7690092684268, 1370.239517068017, 1386.0090035624578, 1389.6456403617215, 32345.35309293848, 34823.65176348305, 35026.92109644138, 35251.65927830714, 35261.29477410386, 52486.47513524969, 53250.2012469821, 53442.0, 53452.46547534475, 53485.73257133689, 460638.0, 465511.0, 474903.0, 475735.0, 476321.0, 44496.77751611221, 44685.776571116934, 45228.547714522436, 47817.52182478131, 49307.50692493029, 49957.0, 50242.0, 50947.235791462415, 51420.0, 51695.0, 42968.0, 43577.346339804295, 43687.56312436835, 43701.0, 44081.338779918966, 42169.1566168681, 42283.577164227965, 42450.0, 42942.282308707305, 43010.12908838094, 41736.79131604323, 42472.5752742481, 42554.78722606367, 43311.35032974571, 43543.12913741644, 35982.0, 37353.94194597675, 38259.0, 38405.6159438402, 38944.80527597344, 28729.42541149207, 29365.706342936297, 29461.26346841346, 29501.0, 29743.851280743456], "value": 20955.739113411237, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.74345547122107, 399.26136647202696, 399.2753153027257, 400.6574378906035, 422.14094318062746, 13923.651908702288, 16425.342986280535, 17642.0, 19133.33033343833, 19152.808471915276, 14913.32890019949, 17634.470965871013, 18324.816751832477, 18585.163667634955, 18591.349302774404, 5643.125315576082, 5834.824955251349, 5838.0, 5844.941550584483, 5862.149988251701, 4160.916781664365, 5723.627964182315, 5806.767729290823, 6100.572959892809, 6561.639109848957, 6511.4465270452065, 6566.63883486408, 6584.539082264243, 6609.074729537869, 6624.3375662433855, 6339.11252424661, 6604.240512341046, 6619.1395118634755, 6623.370779775938, 6627.039079333494, 5769.1346298055205, 5833.212516310286, 5846.50304724099, 5855.121731740273, 5872.442117998783, 22542.887285563465, 23024.88487557568, 23287.301380958597, 23292.534149316918, 23513.88243058791, 2438.6463962725484, 2488.5271798358435, 2578.793696504275, 2668.506326329635, 3147.5121356189597, 13793.517226897011, 14121.435142594284, 14223.21772302523, 14355.210463424508, 14763.852361476462, 1834.8532117430573, 1866.1042699504178, 1867.7478540397008, 1896.6491199128068, 1926.566522532433, 81895.5905220476, 82948.58525707394, 83251.0, 84426.57786711027, 86601.56699216526, 10620.946895265628, 10678.946605266923, 10906.90930906903, 10972.945135274273, 11073.335599864035, 15126.243687815566, 15212.847871521364, 15216.163111028778, 15224.391024359124, 15231.771523426936, 7518.511296765692, 7668.348190403878, 7829.843403132019, 7875.369970402354, 7900.249476299742, 6289.371062893765, 7323.890141647879, 7409.518381305198, 7524.360429363456, 7532.924670753332, 6151.538634602333, 6515.446187074152, 6539.803805885831, 6611.768588099393, 6694.464442844561, 1915.1764741161435, 1997.7103320018516, 2003.5191554026928, 2014.2647933504165, 2016.7680716717766, 898.6719847255836, 1054.593981317183, 1075.8063548561177, 1102.20090434436, 1136.653320737183, 19436.639435239682, 19748.0, 20055.29806456767, 20194.798052019585, 20800.687989680166, 1005.8541511480794, 1027.7944411117805, 1031.185363562777, 1055.2349546578823, 1096.3202814255212, 10905.236633435583, 11480.425978701198, 11526.59656912004, 11539.653810385702, 11541.884581154249, 411267.0, 417055.0, 432839.0, 433410.0, 434867.0, 93296.53351733333, 93857.0, 94953.5252323734, 95285.0, 96913.5154324238, 1003.4581326083833, 1028.4189432970347, 1034.943078130695, 1036.8030074285862, 1041.630221271453, 17504.649907002044, 17602.735958960882, 17783.911080444515, 17921.19354629071, 18385.54036149107, 39396.0, 40334.0, 41657.79171104125, 41859.581404186785, 43089.78455107704, 56871.0, 57670.42329576651, 59180.40819591749, 60683.0, 60914.390856090875, 8213.95893020531, 8347.0, 8437.493750374997, 8504.957475212585, 8523.701670441505, 9443.858342124737, 13366.866331336561, 13440.529581464602, 13715.245661488314, 13816.447342106605, 11640.0, 11681.123915706186, 11720.824187637021, 11789.469473873867, 11872.228305160137, 11240.887591123985, 11310.4910279036, 11642.825357619811, 11655.125865560287, 11865.940670296593, 11682.47428865686, 11717.824232636347, 11978.64064078079, 12223.69440763988, 12340.197887137307, 8553.272971797218, 8587.65649374018, 8589.098144694717, 8685.652573896974, 8727.301815854844, 9024.86462703073, 11498.195126341076, 11935.0, 12134.150609457252, 12230.205036672587], "value": 9451.333138558255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.6489680234745, 1481.5036962617523, 1522.5584580471664, 1647.2834317072075, 1785.3305010621018, 8564.443311184776, 8953.23897468716, 9041.0, 9311.58097885595, 9324.720258392259, 9147.405418647782, 9344.81310373792, 9352.485613291283, 9369.625214991393, 9370.156685898268, 2148.8388370872167, 2220.2340192633515, 2368.7394386617457, 2422.660827484149, 2452.0, 2447.889844956981, 2464.223769512607, 2464.3223113643803, 2466.6300054991716, 2468.0374653885, 2414.5895197816412, 2469.76537228963, 2474.5916923707655, 2476.2942561370014, 2478.033566908898, 2084.9687254691266, 2316.1082983051647, 2384.940376490584, 2386.9283921482383, 2393.270052633946, 2379.3218932604123, 2419.951600967971, 2438.2197696737053, 2439.097533912446, 2441.6825812644242, 9327.347085704003, 9378.812423751555, 9460.148586627236, 9473.90526094744, 9474.336796424253, 5092.439831618519, 5220.686758794484, 5226.477352264781, 5228.032813929397, 5230.581553475713, 3550.4664211556824, 3563.322968635977, 3592.479090531858, 3622.4023036198996, 3711.0907827582146, 1109.6948339206701, 1134.7843909657138, 1143.0683992546049, 1167.2412931594447, 1186.371223251678, 13045.804312935219, 13065.150765200231, 13071.803922941164, 13082.084254102218, 13136.60590182296, 4685.220784991845, 4763.8332658357485, 4817.638677099231, 4832.033593281288, 4844.079624871263, 11064.668059958214, 11123.0, 11126.888731112747, 11131.220814543067, 11134.276272042453, 5265.183896496049, 5270.0, 5271.683698978073, 5273.024490469275, 5276.287701160371, 4286.271333873249, 4650.441946966385, 4774.498677638798, 4783.0, 4849.442314133849, 4138.958610413918, 4171.707980441401, 4207.074443622399, 4248.214080395137, 4254.042840360894, 1243.7015116372006, 1263.216805580546, 1269.2955409747494, 1269.6254604891578, 1292.6251387097825, 999.8050380175941, 1004.3471743366724, 1018.149844879519, 1033.106362996018, 1034.8913364096811, 6494.545381823322, 6604.075429439882, 6625.370589794058, 6638.070670106189, 6701.0, 440.53523532673336, 442.5640743867288, 443.6716829546177, 451.0325352119685, 458.8233530090872, 4216.494020717533, 4354.695171337976, 4358.280883654162, 4370.497392799869, 4456.665750068758, 10972.835407468894, 11293.15301352402, 11640.243384180001, 11709.765804683859, 11723.765524689628, 11326.0, 11546.94226528862, 11674.357910315015, 11676.124290678234, 11704.648860534198, 8499.95750021246, 8676.826463470696, 8688.565571721389, 8690.565471726262, 8696.086910874266, 6332.841678958063, 6480.967595161994, 6633.9668301658185, 6637.734490620321, 6692.56109936366, 10639.14886809069, 10642.574297028032, 10776.084032856981, 10790.838137428102, 10824.188185885932, 10693.786124277627, 10805.675829725122, 10843.512041957973, 10945.945270273598, 10946.616868409568, 7500.587467689329, 8142.8778568322705, 8281.420300578902, 8368.163183681583, 8439.409241353047, 9395.107464790834, 9403.952980235328, 9422.62309507612, 9462.810743784948, 9478.72037274959, 8068.47554908929, 8300.54347010896, 8323.292520135856, 8424.789380265542, 8457.957710211409, 8114.350851931949, 8127.878081828659, 8189.058258300133, 8295.170482951657, 8398.706045288385, 6937.861242775015, 7083.893741593984, 7093.113360829896, 7096.361327480551, 7650.885236721342, 5363.0882749931825, 5367.570594352364, 5370.382406023357, 5436.456354364532, 5729.312482502127, 5474.343078830566, 5496.31296087989, 5568.805091821929, 5580.665160090408, 5670.574706896917], "value": 4762.426714718731, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.8494964891677, 321.4054000099814, 322.51300536190354, 330.1959728062168, 330.20256081563025, 5296.894062118756, 5337.332833395825, 5340.866478338039, 5344.8241386894915, 5367.543758780504, 5148.433672296044, 5230.320058392404, 5233.069481090592, 5240.580753539717, 5258.790478190019, 4078.5105787305565, 4162.916741665165, 4173.707840451169, 4204.810783514734, 4214.346776249671, 4157.023099571598, 4166.64583510402, 4169.478815148106, 4177.95551112222, 4194.7415775267455, 4074.3684728867074, 4147.67274472169, 4157.792110394468, 4160.251154792136, 4173.520045194796, 3960.7623542587535, 4016.5581786003518, 4126.958730412687, 4147.3410635745795, 4180.832766689329, 3655.597884232732, 3667.2665466906724, 3673.2653469306247, 3680.3743363628246, 3683.631636836322, 5127.564157046656, 5134.358205224347, 5141.0, 5146.897062058775, 5150.536451719326, 4572.291294849304, 4610.124076425468, 4707.340972263886, 4742.383490146259, 4748.3114948332295, 5432.891342173174, 5437.0, 5498.752556134984, 5508.779648814043, 5517.834464966058, 4070.2470043041835, 4087.080406908422, 4087.1008378156757, 4110.671146308288, 4111.71218014739, 5623.325200975868, 5665.206871038058, 5681.409205422529, 5687.0, 5742.36342642345, 4113.321301985199, 4121.814518346621, 4137.275976704064, 4144.254034273799, 4149.730267532661, 4197.97901010493, 4220.78896055196, 4221.894452638647, 4225.619694227473, 4227.852025179104, 4587.7074876911165, 4728.834490792806, 4755.548222918817, 4756.548127927841, 4790.640701947368, 5506.531944784738, 5509.256250406143, 5532.585056120726, 5546.168074788733, 5560.165975103686, 1434.763264061418, 1437.7915202295817, 1442.5167568864547, 1443.4298452111357, 1451.528253317676, 924.242121460396, 937.723371605378, 941.4022095969109, 948.5446985447024, 958.7075941837667, 4713.316569097462, 4737.739424331695, 4739.454962679267, 4770.022145460172, 4791.281307803857, 4974.477679843637, 4981.476944920803, 4998.900021999612, 5044.54599086084, 5069.923951140736, 4496.24646387909, 4747.786349614275, 4758.857234282977, 4775.498572649822, 4788.808447662124, 2918.270432391902, 2924.8098873573576, 2975.41979314036, 2991.9401611968074, 3033.4843076677016, 5755.3381361143165, 5763.94236057634, 5785.190073389729, 5802.390748971297, 5871.94128058714, 5509.944900550943, 5749.137629355547, 5771.509421699118, 5784.942150578525, 5843.415658434207, 5845.678487683133, 5855.853603659857, 5883.970580147072, 5889.146073819358, 5905.409459054146, 5483.8080667176455, 5602.89891290766, 5628.4090170533145, 5715.599908006399, 5733.913991290217, 5570.275864137636, 5578.219049333178, 5580.693061881636, 5588.211772232847, 5600.635958662837, 5771.066692658007, 5800.4489573490455, 5807.448292412214, 5809.00836069433, 5811.27359080115, 4004.798560431917, 4096.16028714107, 4104.0, 4108.2810508160355, 4140.482439695038, 5570.693611851387, 5623.915641265303, 5624.775008999758, 5638.605297629127, 5670.886582268414, 5458.580769000168, 5477.835664930059, 5498.147787093007, 5508.980838544882, 5510.996506903667, 5237.0, 5508.614396992172, 5509.724513774215, 5516.862078447911, 5546.611737178358, 5421.918671219856, 5456.017916775018, 5456.345238571397, 5462.426445223195, 5470.8085217017215, 5501.312335958005, 5556.749946252347, 5570.5543556516195, 5579.298314014264, 5594.664320140804, 5222.97388513055, 5472.616916815944, 5514.172874068921, 5515.917261241005, 5530.364008139116], "value": 4190.242154440732, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.8345963887946, 758.8254701418678, 790.1900551934267, 798.92410221029, 812.9349652027838, 15176.772348414783, 15827.52517424479, 15850.76223856643, 15857.3657053718, 15871.920640396811, 15361.692766144699, 15427.151506667129, 15468.767968480453, 15582.376704931788, 15615.609609759733, 665.6838001949084, 774.8682723936917, 775.8409526047161, 795.9880601790978, 798.0543056478064, 792.0772300270207, 795.7334293011847, 800.7037396163428, 802.6709049289792, 803.7869964459394, 862.1335557764438, 865.2558799432483, 872.7687162901836, 873.057098333798, 874.1564390363299, 712.8503014366989, 852.5055467828676, 857.0187135729554, 859.77645812089, 861.1001503428901, 605.6578033411108, 619.3434958943534, 620.2092332276338, 621.266905052043, 621.7668374359615, 14183.858161418357, 14343.56969290923, 14355.856441435557, 14360.712785744332, 14364.784528232085, 13210.339483025906, 13982.300884955814, 13991.160530368108, 14030.649233769136, 14090.577282681536, 10900.890991090067, 12018.579349722717, 12151.608154302932, 12326.0, 12563.434645440977, 4309.806058727333, 4369.3227549729845, 4377.25586650267, 4444.025706125041, 4448.154850578379, 78831.60584197042, 79158.20841791567, 79740.20259797385, 80982.99999999942, 81605.18394816035, 10960.342379457257, 10964.616238431776, 11092.667219983414, 11171.776564468664, 11274.661760147208, 21303.14787408486, 21337.573248534944, 21360.0, 21366.465838353855, 21378.679319810217, 8356.0, 8520.233179013918, 8538.530380829114, 8718.86921696175, 8721.91278087211, 4367.410399596078, 4462.152191083748, 4517.5482451755215, 4529.297958816389, 4535.183666939983, 3514.4201206801104, 3669.94495082574, 3670.6512881276235, 3671.2473942841652, 3673.0, 610.1975901689265, 614.2230078950132, 617.043582447205, 626.9028300613412, 628.8773689130667, 585.859393745498, 589.4724221821446, 643.9710213040424, 666.5001249063203, 696.8954207581041, 8640.956795215983, 8699.304055675531, 8725.389222754473, 9094.0, 9098.999110097884, 498.40758775711976, 536.1876756713582, 559.767696405987, 568.4486048532916, 614.3549273263056, 4346.239408103569, 4395.648348132142, 4400.801963911632, 4482.193205223091, 4557.339185818038, 115081.0, 118931.40534297447, 120593.39703301428, 121058.39470802766, 124247.3787631056, 79906.0, 98324.50837745765, 99670.0, 101092.0, 101398.49300753449, 92142.0, 93098.53450732703, 94889.52555237318, 95377.0, 96387.03612963921, 8506.362022848187, 8532.189442003, 8539.402241843012, 8593.226609605166, 8609.311255099703, 53967.0, 54787.45212547824, 55824.0, 56020.439795601524, 57483.137752932904, 77178.0, 79671.80676173973, 79737.60131199307, 81786.0, 82214.17785822065, 11069.944650276697, 11718.355490448108, 12059.457324420599, 12168.2699038058, 12973.740525189633, 11541.307521548733, 11668.649940501798, 11684.240524365889, 11900.821487677518, 12071.275723456269, 11350.545978161112, 11436.313821170756, 11637.88362116368, 11648.35934023603, 11962.342071186169, 11440.427978601203, 11519.678253375572, 11539.88164735673, 11644.88355116472, 11677.591284305008, 10500.212484063573, 10617.787644247226, 10845.240833141605, 10883.074938630305, 11374.488148033193, 9279.72160835176, 9318.580663870007, 9350.438973661601, 9661.372010819556, 9670.75823104428, 9180.0, 9476.431414115175, 9507.66723164686, 9544.95227523858, 9714.562844671866], "value": 7252.7538533428515, "unit": "score"}], "name": "dromaeo_css", "value": 7291.420611247768, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 111.0, 111.0, 111.0, 110.0, 109.0, 111.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 136.0, 126.0, 179.0, 131.0, 129.0, 155.0, 132.0, 161.0, 124.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 159.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 78.0, 131.0, 75.0, 75.0, 75.0, 74.0, 98.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 84.0, 114.0, 85.0, 86.0, 86.0, 133.0, 85.0, 86.0, 127.0], "value": 98.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 52.0, 55.0, 55.0, 66.0, 54.0, 54.0, 52.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 63.0, 62.0, 63.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 81.0, 79.0, 78.0, 80.0, 80.0, 86.0, 111.0, 87.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 130.0, 121.0, 128.0, 128.0, 118.0, 120.0, 126.0, 124.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 160.0, 162.0, 159.0, 158.0, 157.0, 156.0, 160.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 64.0, 63.0, 65.0, 63.0, 64.0, 63.0, 66.0, 64.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1501.2, "alertThreshold": 2.0}]} 05:57:08 INFO - Return code: 0 05:57:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:57:08 INFO - # TBPL SUCCESS # 05:57:08 INFO - Running post-action listener: _resource_record_post_action 05:57:08 INFO - ##### 05:57:08 INFO - ##### Finished run-tests step (success) 05:57:08 INFO - ##### 05:57:08 INFO - Running post-run listener: _resource_record_post_run 05:57:08 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 548687872; Read time: 248; Write time: 684004 05:57:08 INFO - TinderboxPrint: CPU usage
13.2% 05:57:08 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 248 05:57:08 INFO - TinderboxPrint: I/O write bytes / time
548,687,872 / 684,004 05:57:08 INFO - TinderboxPrint: CPU idle
8,268.6 (86.8%) 05:57:08 INFO - TinderboxPrint: CPU user
1,208.6 (12.7%) 05:57:08 INFO - TinderboxPrint: Swap in / out
0 / 0 05:57:08 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 255254528; Read time: 0; Write time: 380316 05:57:08 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293433344; Read time: 248; Write time: 303688 05:57:09 INFO - Running post-run listener: _upload_blobber_files 05:57:09 INFO - Blob upload gear active. 05:57:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:57:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:57:09 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'] 05:57:09 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 05:57:09 INFO - (blobuploader) - INFO - Open directory for files ... 05:57:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:57:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:57:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:10 INFO - (blobuploader) - INFO - Done attempting. 05:57:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:57:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:57:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:11 INFO - (blobuploader) - INFO - Done attempting. 05:57:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:57:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:57:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:16 INFO - (blobuploader) - INFO - Done attempting. 05:57:16 INFO - (blobuploader) - INFO - Iteration through files over. 05:57:16 INFO - Return code: 0 05:57:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:57:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:57:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad963c3c6eaa0a8462a697283093b79d5176815a89436396deaeb7696ed3f16eac42de7b6dfe7a2b1acb89f12f84606a491c2533fabc784129cb97289281f421", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06a1f975e3ea03db0fe1a69b6f88bb5580aee3098b24537a61622ed527edf27bd4545dd750c7465ddf957f3d8b4a9c5a4341e460a9441ca61f2985692b776844", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e315b42b487538437d84552b71e354092cbb0f664c4be7a2a1e8546512a1d3a74b79c4b4e034376799c17affce861db482dd589fbc34a0b24f4221c56ba50054"} 05:57:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:57:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:57:16 INFO - Contents: 05:57:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad963c3c6eaa0a8462a697283093b79d5176815a89436396deaeb7696ed3f16eac42de7b6dfe7a2b1acb89f12f84606a491c2533fabc784129cb97289281f421", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06a1f975e3ea03db0fe1a69b6f88bb5580aee3098b24537a61622ed527edf27bd4545dd750c7465ddf957f3d8b4a9c5a4341e460a9441ca61f2985692b776844", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e315b42b487538437d84552b71e354092cbb0f664c4be7a2a1e8546512a1d3a74b79c4b4e034376799c17affce861db482dd589fbc34a0b24f4221c56ba50054"} 05:57:16 INFO - Running post-run listener: copy_logs_to_upload_dir 05:57:16 INFO - Copying logs to upload dir... 05:57:16 INFO - mkdir: /builds/slave/test/build/upload/logs 05:57:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.910273 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-14 05:57:16.224145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 05:57:16.227733) ========= 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=62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad963c3c6eaa0a8462a697283093b79d5176815a89436396deaeb7696ed3f16eac42de7b6dfe7a2b1acb89f12f84606a491c2533fabc784129cb97289281f421", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06a1f975e3ea03db0fe1a69b6f88bb5580aee3098b24537a61622ed527edf27bd4545dd750c7465ddf957f3d8b4a9c5a4341e460a9441ca61f2985692b776844", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e315b42b487538437d84552b71e354092cbb0f664c4be7a2a1e8546512a1d3a74b79c4b4e034376799c17affce861db482dd589fbc34a0b24f4221c56ba50054"} build_url:https://queue.taskcluster.net/v1/task/McDXEmueQka-kMw0Ryl8SQ/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/McDXEmueQka-kMw0Ryl8SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad963c3c6eaa0a8462a697283093b79d5176815a89436396deaeb7696ed3f16eac42de7b6dfe7a2b1acb89f12f84606a491c2533fabc784129cb97289281f421", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06a1f975e3ea03db0fe1a69b6f88bb5580aee3098b24537a61622ed527edf27bd4545dd750c7465ddf957f3d8b4a9c5a4341e460a9441ca61f2985692b776844", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e315b42b487538437d84552b71e354092cbb0f664c4be7a2a1e8546512a1d3a74b79c4b4e034376799c17affce861db482dd589fbc34a0b24f4221c56ba50054"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 05:57:16.253012) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:57:16.253355) ========= 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=62c568580acbfdaac3eec7be000001dc-1465906534.895762-433296162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:57:16.335399) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 05:57:16.335736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 05:57:16.336045) ========= ========= Total master_lag: 0.18 =========