builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1467738685.3 results: success (0) buildid: 20160705073513 builduid: 95ca1a2b05614b469959fce6fb60efd4 revision: 31348bf997584cddcac6d741c1070c03f4a5ca5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:25.302460) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:25.302910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:25.303219) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:25.323826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:25.324119) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 10:11:28-- 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% 40.6M=0s 2016-07-05 10:11:28 (40.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170040 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:25.508380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:25.508679) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014207 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:25.557541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:25.557909) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 31348bf997584cddcac6d741c1070c03f4a5ca5c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 31348bf997584cddcac6d741c1070c03f4a5ca5c --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=3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 10:11:28,938 truncating revision to first 12 chars 2016-07-05 10:11:28,938 Setting DEBUG logging. 2016-07-05 10:11:28,938 attempt 1/10 2016-07-05 10:11:28,938 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/31348bf99758?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 10:11:29,297 unpacking tar archive at: mozilla-aurora-31348bf99758/testing/mozharness/ program finished with exit code 0 elapsedTime=0.687405 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:26.258708) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:26.259020) ========= script_repo_revision: 31348bf997584cddcac6d741c1070c03f4a5ca5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:26.259434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:26.259732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:11:26.271295) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-05 10:11:26.271586) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:29 INFO - MultiFileLogger online at 20160705 10:11:29 in /builds/slave/test 10:11:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:11:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:29 INFO - {'append_to_log': False, 10:11:29 INFO - 'base_work_dir': '/builds/slave/test', 10:11:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:11:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:29 INFO - 'branch': 'Mozilla-Aurora', 10:11:29 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:29 INFO - 'config_files': ('talos/linux_config.py',), 10:11:29 INFO - 'default_actions': ('clobber', 10:11:29 INFO - 'read-buildbot-config', 10:11:29 INFO - 'download-and-extract', 10:11:29 INFO - 'populate-webroot', 10:11:29 INFO - 'create-virtualenv', 10:11:29 INFO - 'install', 10:11:29 INFO - 'run-tests'), 10:11:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:29 INFO - 'download_minidump_stackwalk': True, 10:11:29 INFO - 'download_symbols': 'ondemand', 10:11:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:29 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:29 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:29 INFO - 'installer_path': 'installer.exe', 10:11:29 INFO - 'log_level': 'info', 10:11:29 INFO - 'log_name': 'talos', 10:11:29 INFO - 'log_to_console': True, 10:11:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:29 INFO - 'opt_config_files': (), 10:11:29 INFO - 'pip_index': False, 10:11:29 INFO - 'sps_profile': False, 10:11:29 INFO - 'sps_profile_interval': 0, 10:11:29 INFO - 'suite': 'dromaeojs', 10:11:29 INFO - 'system_bits': '32', 10:11:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:29 INFO - 'title': 'talos-linux64-ix-059', 10:11:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:29 INFO - 'use_talos_json': True, 10:11:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:29 INFO - 'work_dir': 'build'} 10:11:29 INFO - ##### 10:11:29 INFO - ##### Running clobber step. 10:11:29 INFO - ##### 10:11:29 INFO - Running pre-action listener: _resource_record_pre_action 10:11:29 INFO - Running main action method: clobber 10:11:29 INFO - rmtree: /builds/slave/test/build 10:11:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:30 INFO - Running post-action listener: _resource_record_post_action 10:11:30 INFO - ##### 10:11:30 INFO - ##### Finished clobber step (success) 10:11:30 INFO - ##### 10:11:30 INFO - ##### 10:11:30 INFO - ##### Running read-buildbot-config step. 10:11:30 INFO - ##### 10:11:30 INFO - Running pre-action listener: _resource_record_pre_action 10:11:30 INFO - Running main action method: read_buildbot_config 10:11:30 INFO - Using buildbot properties: 10:11:30 INFO - { 10:11:30 INFO - "project": "", 10:11:30 INFO - "product": "firefox", 10:11:30 INFO - "script_repo_revision": "production", 10:11:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:11:30 INFO - "repository": "", 10:11:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:11:30 INFO - "buildid": "20160705073513", 10:11:30 INFO - "pgo_build": "True", 10:11:30 INFO - "basedir": "/builds/slave/test", 10:11:30 INFO - "buildnumber": 590, 10:11:30 INFO - "slavename": "talos-linux64-ix-059", 10:11:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:11:30 INFO - "platform": "ubuntu64_hw", 10:11:30 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:11:30 INFO - "branch": "mozilla-aurora", 10:11:30 INFO - "repo_path": "releases/mozilla-aurora", 10:11:30 INFO - "revision": "31348bf997584cddcac6d741c1070c03f4a5ca5c", 10:11:30 INFO - "stage_platform": "linux64-pgo", 10:11:30 INFO - "builduid": "95ca1a2b05614b469959fce6fb60efd4", 10:11:30 INFO - "slavebuilddir": "test" 10:11:30 INFO - } 10:11:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 10:11:30 INFO - Running post-action listener: _resource_record_post_action 10:11:30 INFO - ##### 10:11:30 INFO - ##### Finished read-buildbot-config step (success) 10:11:30 INFO - ##### 10:11:30 INFO - ##### 10:11:30 INFO - ##### Running download-and-extract step. 10:11:30 INFO - ##### 10:11:30 INFO - Running pre-action listener: _resource_record_pre_action 10:11:30 INFO - Running main action method: download_and_extract 10:11:30 INFO - mkdir: /builds/slave/test/build/tests 10:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:30 INFO - https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:11:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:11:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:11:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:11:30 INFO - Downloaded 1361 bytes. 10:11:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:11:30 INFO - Using the following test package requirements: 10:11:30 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:11:30 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:11:30 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:11:30 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:30 INFO - u'jsshell-linux-x86_64.zip'], 10:11:30 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:11:30 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:11:30 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:11:30 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:11:30 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:11:30 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:11:30 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:11:30 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:30 INFO - https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:11:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:11:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:11:32 INFO - Downloaded 24526575 bytes. 10:11:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:11:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:11:33 INFO - Return code: 0 10:11:33 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:11: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')]} 10:11:33 INFO - https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:11:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:11:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:11:34 INFO - Downloaded 24526575 bytes. 10:11:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:11:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:11:36 INFO - Return code: 0 10:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:36 INFO - https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:11:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:11:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:11:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:11:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:11:37 INFO - Downloaded 10833369 bytes. 10:11:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:11:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:11:37 INFO - Return code: 0 10:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:37 INFO - https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:11:38 INFO - Downloaded 63600873 bytes. 10:11:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:11:38 INFO - mkdir: /builds/slave/test/properties 10:11:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:11:38 INFO - Writing to file /builds/slave/test/properties/build_url 10:11:38 INFO - Contents: 10:11:38 INFO - build_url:https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:11:39 INFO - Running post-action listener: _resource_record_post_action 10:11:39 INFO - Running post-action listener: set_extra_try_arguments 10:11:39 INFO - ##### 10:11:39 INFO - ##### Finished download-and-extract step (success) 10:11:39 INFO - ##### 10:11:39 INFO - ##### 10:11:39 INFO - ##### Running populate-webroot step. 10:11:39 INFO - ##### 10:11:39 INFO - Running pre-action listener: _resource_record_pre_action 10:11:39 INFO - Running main action method: populate_webroot 10:11:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:11:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:11:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:11:39 INFO - '--tppagecycles', 10:11:39 INFO - '7'], 10:11:39 INFO - 'tests': ['tsvgm']}}, 10:11:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:11:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:11:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:11:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:11:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:11:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:11:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:39 INFO - 'talos_options': ['--disable-e10s'], 10:11:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:39 INFO - 'talos_options': ['--disable-e10s'], 10:11:39 INFO - 'tests': ['damp', 'tps']}, 10:11:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:39 INFO - 'tests': ['damp', 'tps']}, 10:11:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:11:39 INFO - 'tests': ['dromaeo_dom']}, 10:11:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:11:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:11:39 INFO - 'tests': ['a11yr', 10:11:39 INFO - 'ts_paint', 10:11:39 INFO - 'tpaint', 10:11:39 INFO - 'sessionrestore', 10:11:39 INFO - 'sessionrestore_no_auto_restore', 10:11:39 INFO - 'tabpaint']}, 10:11:39 INFO - 'other-e10s': {'tests': ['a11yr', 10:11:39 INFO - 'ts_paint', 10:11:39 INFO - 'tpaint', 10:11:39 INFO - 'sessionrestore', 10:11:39 INFO - 'sessionrestore_no_auto_restore', 10:11:39 INFO - 'tabpaint']}, 10:11:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:11:39 INFO - 'ts_paint', 10:11:39 INFO - 'tpaint', 10:11:39 INFO - 'sessionrestore', 10:11:39 INFO - 'sessionrestore_no_auto_restore', 10:11:39 INFO - 'tabpaint']}, 10:11:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:11:39 INFO - 'ts_paint', 10:11:39 INFO - 'tpaint', 10:11:39 INFO - 'sessionrestore', 10:11:39 INFO - 'sessionrestore_no_auto_restore', 10:11:39 INFO - 'tabpaint']}, 10:11:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:11:39 INFO - 'tests': ['a11yr', 10:11:39 INFO - 'ts_paint', 10:11:39 INFO - 'tpaint', 10:11:39 INFO - 'sessionrestore', 10:11:39 INFO - 'sessionrestore_no_auto_restore', 10:11:39 INFO - 'tabpaint']}, 10:11:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:11:39 INFO - 'tests': ['a11yr', 10:11:39 INFO - 'ts_paint', 10:11:39 INFO - 'tpaint', 10:11:39 INFO - 'sessionrestore', 10:11:39 INFO - 'sessionrestore_no_auto_restore', 10:11:39 INFO - 'tabpaint']}, 10:11:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:11:39 INFO - 'tests': ['tsvgx', 10:11:39 INFO - 'tsvgr_opacity', 10:11:39 INFO - 'tart', 10:11:39 INFO - 'tscrollx', 10:11:39 INFO - 'cart']}, 10:11:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:11:39 INFO - 'tsvgr_opacity', 10:11:39 INFO - 'tart', 10:11:39 INFO - 'tscrollx', 10:11:39 INFO - 'cart']}, 10:11:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:39 INFO - 'talos_options': ['--disable-e10s'], 10:11:39 INFO - 'tests': ['tp5o']}, 10:11:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:39 INFO - 'tests': ['tp5o']}, 10:11:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:39 INFO - 'talos_options': ['--disable-e10s', 10:11:39 INFO - '--xperf_path', 10:11:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:39 INFO - 'tests': ['tp5n']}, 10:11:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:39 INFO - 'talos_options': ['--xperf_path', 10:11:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:39 INFO - 'tests': ['tp5n']}}, 10:11:39 INFO - 'talos.zip': {'path': '', 10:11:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:11:39 INFO - Running post-action listener: _resource_record_post_action 10:11:39 INFO - ##### 10:11:39 INFO - ##### Finished populate-webroot step (success) 10:11:39 INFO - ##### 10:11:39 INFO - ##### 10:11:39 INFO - ##### Running create-virtualenv step. 10:11:39 INFO - ##### 10:11:39 INFO - Running pre-action listener: _resource_record_pre_action 10:11:39 INFO - Running main action method: create_virtualenv 10:11:39 INFO - Creating virtualenv /builds/slave/test/build/venv 10:11:39 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 10:11:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:11:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:11:39 INFO - Using real prefix '/usr' 10:11:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:11:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:11:41 INFO - Installing pip.................done. 10:11:41 INFO - Return code: 0 10:11:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbaf5fb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', '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 10:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:11:41 INFO - Using env: {'DISPLAY': ':0', 10:11:41 INFO - 'HOME': '/home/cltbld', 10:11:41 INFO - 'LANG': 'en_US.UTF-8', 10:11:41 INFO - 'LANGUAGE': 'en_US:en', 10:11:41 INFO - 'LOGNAME': 'cltbld', 10:11:41 INFO - 'MAIL': '/var/mail/cltbld', 10:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:41 INFO - 'MOZ_NO_REMOTE': '1', 10:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:41 INFO - 'NO_EM_RESTART': '1', 10:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:41 INFO - 'PWD': '/builds/slave/test', 10:11:41 INFO - 'SHELL': '/bin/bash', 10:11:41 INFO - 'SHLVL': '1', 10:11:41 INFO - 'TERM': 'linux', 10:11:41 INFO - 'TMOUT': '86400', 10:11:41 INFO - 'USER': 'cltbld', 10:11:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:41 INFO - '_': '/tools/buildbot/bin/python'} 10:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:42 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 10:11:42 INFO - Cleaning up... 10:11:42 INFO - Return code: 0 10:11:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:42 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 0x7fbaf5fb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', '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 10:11:42 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 10:11:42 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 10:11:42 INFO - Using env: {'DISPLAY': ':0', 10:11:42 INFO - 'HOME': '/home/cltbld', 10:11:42 INFO - 'LANG': 'en_US.UTF-8', 10:11:42 INFO - 'LANGUAGE': 'en_US:en', 10:11:42 INFO - 'LOGNAME': 'cltbld', 10:11:42 INFO - 'MAIL': '/var/mail/cltbld', 10:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:42 INFO - 'MOZ_NO_REMOTE': '1', 10:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:42 INFO - 'NO_EM_RESTART': '1', 10:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:42 INFO - 'PWD': '/builds/slave/test', 10:11:42 INFO - 'SHELL': '/bin/bash', 10:11:42 INFO - 'SHLVL': '1', 10:11:42 INFO - 'TERM': 'linux', 10:11:42 INFO - 'TMOUT': '86400', 10:11:42 INFO - 'USER': 'cltbld', 10:11:42 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:42 INFO - '_': '/tools/buildbot/bin/python'} 10:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:42 INFO - Downloading/unpacking psutil>=3.1.1 10:11:42 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 10:11:42 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 10:11:42 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 10:11:42 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 10:11:42 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 10:11:42 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 10:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:11:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:44 INFO - Installing collected packages: psutil 10:11:44 INFO - Running setup.py install for psutil 10:11:44 INFO - building 'psutil._psutil_linux' extension 10:11:44 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 10:11:44 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 10:11:44 INFO - building 'psutil._psutil_posix' extension 10:11:44 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 10:11:44 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 10:11:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:44 INFO - Successfully installed psutil 10:11:44 INFO - Cleaning up... 10:11:44 INFO - Return code: 0 10:11:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:44 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 0x7fbaf5fb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', '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 10:11:44 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 10:11:44 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 10:11:44 INFO - Using env: {'DISPLAY': ':0', 10:11:44 INFO - 'HOME': '/home/cltbld', 10:11:44 INFO - 'LANG': 'en_US.UTF-8', 10:11:44 INFO - 'LANGUAGE': 'en_US:en', 10:11:44 INFO - 'LOGNAME': 'cltbld', 10:11:44 INFO - 'MAIL': '/var/mail/cltbld', 10:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:44 INFO - 'MOZ_NO_REMOTE': '1', 10:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:44 INFO - 'NO_EM_RESTART': '1', 10:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:44 INFO - 'PWD': '/builds/slave/test', 10:11:44 INFO - 'SHELL': '/bin/bash', 10:11:44 INFO - 'SHLVL': '1', 10:11:44 INFO - 'TERM': 'linux', 10:11:44 INFO - 'TMOUT': '86400', 10:11:44 INFO - 'USER': 'cltbld', 10:11:44 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:44 INFO - '_': '/tools/buildbot/bin/python'} 10:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:11:45 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 10:11:45 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 10:11:45 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 10:11:45 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 10:11:45 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 10:11:45 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 10:11:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:11:47 INFO - Installing collected packages: mozsystemmonitor 10:11:47 INFO - Running setup.py install for mozsystemmonitor 10:11:47 INFO - Successfully installed mozsystemmonitor 10:11:47 INFO - Cleaning up... 10:11:47 INFO - Return code: 0 10:11:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:47 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 0x7fbaf5fb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', '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 10:11:47 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 10:11:47 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 10:11:47 INFO - Using env: {'DISPLAY': ':0', 10:11:47 INFO - 'HOME': '/home/cltbld', 10:11:47 INFO - 'LANG': 'en_US.UTF-8', 10:11:47 INFO - 'LANGUAGE': 'en_US:en', 10:11:47 INFO - 'LOGNAME': 'cltbld', 10:11:47 INFO - 'MAIL': '/var/mail/cltbld', 10:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:47 INFO - 'MOZ_NO_REMOTE': '1', 10:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:47 INFO - 'NO_EM_RESTART': '1', 10:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:47 INFO - 'PWD': '/builds/slave/test', 10:11:47 INFO - 'SHELL': '/bin/bash', 10:11:47 INFO - 'SHLVL': '1', 10:11:47 INFO - 'TERM': 'linux', 10:11:47 INFO - 'TMOUT': '86400', 10:11:47 INFO - 'USER': 'cltbld', 10:11:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:47 INFO - '_': '/tools/buildbot/bin/python'} 10:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:47 INFO - Downloading/unpacking jsonschema==2.5.1 10:11:47 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 10:11:47 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 10:11:47 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 10:11:47 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 10:11:47 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 10:11:47 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 10:11:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:11:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:49 INFO - Downloading functools32-3.2.3-2.tar.gz 10:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:11:49 INFO - warning: no files found matching '*.txt' 10:11:49 INFO - no previously-included directories found matching 'build' 10:11:49 INFO - no previously-included directories found matching 'dist' 10:11:49 INFO - no previously-included directories found matching '.git*' 10:11:49 INFO - Installing collected packages: jsonschema, functools32 10:11:49 INFO - Running setup.py install for functools32 10:11:49 INFO - warning: no files found matching '*.txt' 10:11:49 INFO - no previously-included directories found matching 'build' 10:11:49 INFO - no previously-included directories found matching 'dist' 10:11:49 INFO - no previously-included directories found matching '.git*' 10:11:49 INFO - Successfully installed jsonschema functools32 10:11:49 INFO - Cleaning up... 10:11:49 INFO - Return code: 0 10:11:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:11:49 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')]} 10:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:49 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')]} 10:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:49 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 0x7fbaf5fb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', '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 10:11:49 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 10:11:49 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 10:11:49 INFO - Using env: {'DISPLAY': ':0', 10:11:49 INFO - 'HOME': '/home/cltbld', 10:11:49 INFO - 'LANG': 'en_US.UTF-8', 10:11:49 INFO - 'LANGUAGE': 'en_US:en', 10:11:49 INFO - 'LOGNAME': 'cltbld', 10:11:49 INFO - 'MAIL': '/var/mail/cltbld', 10:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:49 INFO - 'MOZ_NO_REMOTE': '1', 10:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:49 INFO - 'NO_EM_RESTART': '1', 10:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:49 INFO - 'PWD': '/builds/slave/test', 10:11:49 INFO - 'SHELL': '/bin/bash', 10:11:49 INFO - 'SHLVL': '1', 10:11:49 INFO - 'TERM': 'linux', 10:11:49 INFO - 'TMOUT': '86400', 10:11:49 INFO - 'USER': 'cltbld', 10:11:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:49 INFO - '_': '/tools/buildbot/bin/python'} 10:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:11:50 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 10:11:50 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 10:11:50 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 10:11:50 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 10:11:50 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 10:11:50 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 10:11:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:11:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:11:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:52 INFO - Downloading docopt-0.6.1.tar.gz 10:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:11:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:11:52 INFO - Running setup.py install for blobuploader 10:11:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:11:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:11:52 INFO - Running setup.py install for requests 10:11:53 INFO - Running setup.py install for docopt 10:11:53 INFO - Successfully installed blobuploader requests docopt 10:11:53 INFO - Cleaning up... 10:11:53 INFO - Return code: 0 10:11:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:53 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 0x7fbaf5fb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', '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 10:11:53 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 10:11:53 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 10:11:53 INFO - Using env: {'DISPLAY': ':0', 10:11:53 INFO - 'HOME': '/home/cltbld', 10:11:53 INFO - 'LANG': 'en_US.UTF-8', 10:11:53 INFO - 'LANGUAGE': 'en_US:en', 10:11:53 INFO - 'LOGNAME': 'cltbld', 10:11:53 INFO - 'MAIL': '/var/mail/cltbld', 10:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:53 INFO - 'MOZ_NO_REMOTE': '1', 10:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:53 INFO - 'NO_EM_RESTART': '1', 10:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:53 INFO - 'PWD': '/builds/slave/test', 10:11:53 INFO - 'SHELL': '/bin/bash', 10:11:53 INFO - 'SHLVL': '1', 10:11:53 INFO - 'TERM': 'linux', 10:11:53 INFO - 'TMOUT': '86400', 10:11:53 INFO - 'USER': 'cltbld', 10:11:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:53 INFO - '_': '/tools/buildbot/bin/python'} 10:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:53 INFO - Running setup.py (path:/tmp/pip-1c1RAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:53 INFO - Running setup.py (path:/tmp/pip-FLygIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:53 INFO - Running setup.py (path:/tmp/pip-Tz0rht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:53 INFO - Running setup.py (path:/tmp/pip-PyaBMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:53 INFO - Running setup.py (path:/tmp/pip-EXbitI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:53 INFO - Running setup.py (path:/tmp/pip-b4donk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:54 INFO - Running setup.py (path:/tmp/pip-d_2OWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:54 INFO - Running setup.py (path:/tmp/pip-gS3dYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:54 INFO - Running setup.py (path:/tmp/pip-n_VXPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:54 INFO - Running setup.py (path:/tmp/pip-RObFhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:54 INFO - Running setup.py (path:/tmp/pip-j5iGPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:54 INFO - Running setup.py (path:/tmp/pip-NQUa5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:54 INFO - Running setup.py (path:/tmp/pip-xkCGM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:54 INFO - Running setup.py (path:/tmp/pip-vilde8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:54 INFO - Running setup.py (path:/tmp/pip-tQ_iM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:54 INFO - Running setup.py (path:/tmp/pip-wN_irb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:54 INFO - Running setup.py (path:/tmp/pip-vKJRmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:11:54 INFO - Running setup.py install for manifestparser 10:11:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:11:54 INFO - Running setup.py install for mozcrash 10:11:54 INFO - Running setup.py install for mozdebug 10:11:55 INFO - Running setup.py install for mozdevice 10:11:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozfile 10:11:55 INFO - Running setup.py install for mozhttpd 10:11:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozinfo 10:11:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozInstall 10:11:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozleak 10:11:55 INFO - Running setup.py install for mozlog 10:11:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for moznetwork 10:11:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozprocess 10:11:56 INFO - Running setup.py install for mozprofile 10:11:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Running setup.py install for mozrunner 10:11:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Running setup.py install for mozscreenshot 10:11:56 INFO - Running setup.py install for moztest 10:11:56 INFO - Running setup.py install for mozversion 10:11:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:11:56 INFO - Cleaning up... 10:11:56 INFO - Return code: 0 10:11:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:56 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 0x7fbaf5fb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', '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 10:11:56 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 10:11:56 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 10:11:56 INFO - Using env: {'DISPLAY': ':0', 10:11:56 INFO - 'HOME': '/home/cltbld', 10:11:56 INFO - 'LANG': 'en_US.UTF-8', 10:11:56 INFO - 'LANGUAGE': 'en_US:en', 10:11:56 INFO - 'LOGNAME': 'cltbld', 10:11:56 INFO - 'MAIL': '/var/mail/cltbld', 10:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:56 INFO - 'MOZ_NO_REMOTE': '1', 10:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:56 INFO - 'NO_EM_RESTART': '1', 10:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:56 INFO - 'PWD': '/builds/slave/test', 10:11:56 INFO - 'SHELL': '/bin/bash', 10:11:56 INFO - 'SHLVL': '1', 10:11:56 INFO - 'TERM': 'linux', 10:11:56 INFO - 'TMOUT': '86400', 10:11:56 INFO - 'USER': 'cltbld', 10:11:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:56 INFO - '_': '/tools/buildbot/bin/python'} 10:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:56 INFO - Running setup.py (path:/tmp/pip-6o_oAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:56 INFO - Running setup.py (path:/tmp/pip-hczjXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:56 INFO - Running setup.py (path:/tmp/pip-buljst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:57 INFO - Running setup.py (path:/tmp/pip-FUv0wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:57 INFO - Running setup.py (path:/tmp/pip-o9IZbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:57 INFO - Running setup.py (path:/tmp/pip-BWu2FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:57 INFO - Running setup.py (path:/tmp/pip-z5DuV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:57 INFO - Running setup.py (path:/tmp/pip-eQJfP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:57 INFO - Running setup.py (path:/tmp/pip-gwdpbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:57 INFO - Running setup.py (path:/tmp/pip-JjAKfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:57 INFO - Running setup.py (path:/tmp/pip-cVWSz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:57 INFO - Running setup.py (path:/tmp/pip-fV3ryF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:57 INFO - Running setup.py (path:/tmp/pip-5CRUjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:57 INFO - Running setup.py (path:/tmp/pip-LnCRIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:57 INFO - Running setup.py (path:/tmp/pip-jnbYIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:57 INFO - Running setup.py (path:/tmp/pip-PHPfok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:57 INFO - Running setup.py (path:/tmp/pip-YO6aQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:58 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)) 10:11:58 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)) 10:11:58 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)) 10:11:58 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)) 10:11:58 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)) 10:11:58 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)) 10:11:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:59 INFO - Downloading blessings-1.6.tar.gz 10:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:00 INFO - Installing collected packages: blessings 10:12:00 INFO - Running setup.py install for blessings 10:12:00 INFO - Successfully installed blessings 10:12:00 INFO - Cleaning up... 10:12:00 INFO - Return code: 0 10:12:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:00 INFO - Reading from file tmpfile_stdout 10:12:00 INFO - Current package versions: 10:12:00 INFO - argparse == 1.2.1 10:12:00 INFO - blessings == 1.6 10:12:00 INFO - blobuploader == 1.2.4 10:12:00 INFO - docopt == 0.6.1 10:12:00 INFO - functools32 == 3.2.3-2 10:12:00 INFO - jsonschema == 2.5.1 10:12:00 INFO - manifestparser == 1.1 10:12:00 INFO - mozInstall == 1.12 10:12:00 INFO - mozcrash == 0.17 10:12:00 INFO - mozdebug == 0.1 10:12:00 INFO - mozdevice == 0.48 10:12:00 INFO - mozfile == 1.2 10:12:00 INFO - mozhttpd == 0.7 10:12:00 INFO - mozinfo == 0.9 10:12:00 INFO - mozleak == 0.1 10:12:00 INFO - mozlog == 3.2 10:12:00 INFO - moznetwork == 0.27 10:12:00 INFO - mozprocess == 0.22 10:12:00 INFO - mozprofile == 0.28 10:12:00 INFO - mozrunner == 6.11 10:12:00 INFO - mozscreenshot == 0.1 10:12:00 INFO - mozsystemmonitor == 0.3 10:12:00 INFO - moztest == 0.7 10:12:00 INFO - mozversion == 1.4 10:12:00 INFO - psutil == 3.1.1 10:12:00 INFO - requests == 1.2.3 10:12:00 INFO - wsgiref == 0.1.2 10:12:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:00 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 0x7fbaf5fb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', '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 10:12:00 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 10:12:00 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 10:12:00 INFO - Using env: {'DISPLAY': ':0', 10:12:00 INFO - 'HOME': '/home/cltbld', 10:12:00 INFO - 'LANG': 'en_US.UTF-8', 10:12:00 INFO - 'LANGUAGE': 'en_US:en', 10:12:00 INFO - 'LOGNAME': 'cltbld', 10:12:00 INFO - 'MAIL': '/var/mail/cltbld', 10:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:00 INFO - 'MOZ_NO_REMOTE': '1', 10:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:00 INFO - 'NO_EM_RESTART': '1', 10:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:00 INFO - 'PWD': '/builds/slave/test', 10:12:00 INFO - 'SHELL': '/bin/bash', 10:12:00 INFO - 'SHLVL': '1', 10:12:00 INFO - 'TERM': 'linux', 10:12:00 INFO - 'TMOUT': '86400', 10:12:00 INFO - 'USER': 'cltbld', 10:12:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:00 INFO - '_': '/tools/buildbot/bin/python'} 10:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 INFO - Cleaning up... 10:12:00 INFO - Return code: 0 10:12:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:00 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 0x7fbaf5fb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', '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 10:12:00 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 10:12:00 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 10:12:00 INFO - Using env: {'DISPLAY': ':0', 10:12:00 INFO - 'HOME': '/home/cltbld', 10:12:00 INFO - 'LANG': 'en_US.UTF-8', 10:12:00 INFO - 'LANGUAGE': 'en_US:en', 10:12:00 INFO - 'LOGNAME': 'cltbld', 10:12:00 INFO - 'MAIL': '/var/mail/cltbld', 10:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:00 INFO - 'MOZ_NO_REMOTE': '1', 10:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:00 INFO - 'NO_EM_RESTART': '1', 10:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:00 INFO - 'PWD': '/builds/slave/test', 10:12:00 INFO - 'SHELL': '/bin/bash', 10:12:00 INFO - 'SHLVL': '1', 10:12:00 INFO - 'TERM': 'linux', 10:12:00 INFO - 'TMOUT': '86400', 10:12:00 INFO - 'USER': 'cltbld', 10:12:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:00 INFO - '_': '/tools/buildbot/bin/python'} 10:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:12:00 INFO - Cleaning up... 10:12:00 INFO - Return code: 0 10:12:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:00 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 0x7fbaf5fb8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', '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 10:12:00 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 10:12:00 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 10:12:00 INFO - Using env: {'DISPLAY': ':0', 10:12:00 INFO - 'HOME': '/home/cltbld', 10:12:00 INFO - 'LANG': 'en_US.UTF-8', 10:12:00 INFO - 'LANGUAGE': 'en_US:en', 10:12:00 INFO - 'LOGNAME': 'cltbld', 10:12:00 INFO - 'MAIL': '/var/mail/cltbld', 10:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:00 INFO - 'MOZ_NO_REMOTE': '1', 10:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:00 INFO - 'NO_EM_RESTART': '1', 10:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:00 INFO - 'PWD': '/builds/slave/test', 10:12:00 INFO - 'SHELL': '/bin/bash', 10:12:00 INFO - 'SHLVL': '1', 10:12:00 INFO - 'TERM': 'linux', 10:12:00 INFO - 'TMOUT': '86400', 10:12:00 INFO - 'USER': 'cltbld', 10:12:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:00 INFO - '_': '/tools/buildbot/bin/python'} 10:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:01 INFO - Downloading/unpacking flake8 10:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:12:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:12:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:12:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:03 INFO - no previously-included directories found matching 'docs/_build' 10:12:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:12:03 INFO - Running setup.py install for pep8 10:12:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:03 INFO - no previously-included directories found matching 'docs/_build' 10:12:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:12:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:12:03 INFO - Cleaning up... 10:12:03 INFO - Return code: 0 10:12:03 INFO - Running post-action listener: _resource_record_post_action 10:12:03 INFO - Running post-action listener: _start_resource_monitoring 10:12:03 INFO - Starting resource monitoring. 10:12:03 INFO - ##### 10:12:03 INFO - ##### Finished create-virtualenv step (success) 10:12:03 INFO - ##### 10:12:03 INFO - ##### 10:12:03 INFO - ##### Running install step. 10:12:03 INFO - ##### 10:12:03 INFO - Running pre-action listener: _resource_record_pre_action 10:12:03 INFO - Running main action method: install 10:12:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:04 INFO - Reading from file tmpfile_stdout 10:12:04 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:04 INFO - Reading from file tmpfile_stdout 10:12:04 INFO - Output received: 10:12:04 INFO - Usage: mozinstall [options] installer 10:12:04 INFO - Options: 10:12:04 INFO - -h, --help show this help message and exit 10:12:04 INFO - -d DEST, --destination=DEST 10:12:04 INFO - Directory to install application into. [default: 10:12:04 INFO - "/builds/slave/test"] 10:12:04 INFO - --app=APP Application being installed. [default: firefox] 10:12:04 INFO - mkdir: /builds/slave/test/build/application 10:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:12:20 INFO - Reading from file tmpfile_stdout 10:12:20 INFO - Output received: 10:12:20 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:20 INFO - Running post-action listener: _resource_record_post_action 10:12:20 INFO - ##### 10:12:20 INFO - ##### Finished install step (success) 10:12:20 INFO - ##### 10:12:20 INFO - ##### 10:12:20 INFO - ##### Running run-tests step. 10:12:20 INFO - ##### 10:12:20 INFO - Running pre-action listener: _resource_record_pre_action 10:12:20 INFO - Running main action method: run_tests 10:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:20 INFO - Python 2.7.3 10:12:20 INFO - Return code: 0 10:12:20 INFO - grabbing minidump binary from tooltool 10:12:20 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')]} 10:12:20 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 0x25642e0>, '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 0x24d0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d05d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:20 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 10:12:20 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 10:12:20 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 10:12:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:20 INFO - Return code: 0 10:12:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:12:21 INFO - Return code: 0 10:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 10:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 10:12:21 INFO - Using env: {'DISPLAY': ':0', 10:12:21 INFO - 'HOME': '/home/cltbld', 10:12:21 INFO - 'LANG': 'en_US.UTF-8', 10:12:21 INFO - 'LANGUAGE': 'en_US:en', 10:12:21 INFO - 'LOGNAME': 'cltbld', 10:12:21 INFO - 'MAIL': '/var/mail/cltbld', 10:12:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:21 INFO - 'MOZ_NO_REMOTE': '1', 10:12:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:21 INFO - 'NO_EM_RESTART': '1', 10:12:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:21 INFO - 'PWD': '/builds/slave/test', 10:12:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:21 INFO - 'SHELL': '/bin/bash', 10:12:21 INFO - 'SHLVL': '1', 10:12:21 INFO - 'TERM': 'linux', 10:12:21 INFO - 'TMOUT': '86400', 10:12:21 INFO - 'USER': 'cltbld', 10:12:21 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290', 10:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:21 INFO - '_': '/tools/buildbot/bin/python'} 10:12:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 10:12:21 INFO - mozversion application_buildid: 20160705073513 10:12:21 INFO - mozversion application_changeset: 31348bf997584cddcac6d741c1070c03f4a5ca5c 10:12:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:12:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:21 INFO - mozversion application_name: Firefox 10:12:21 INFO - mozversion application_remotingname: firefox-dev 10:12:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:12:21 INFO - mozversion application_vendor: Mozilla 10:12:21 INFO - mozversion application_version: 49.0a2 10:12:21 INFO - mozversion platform_buildid: 20160705073513 10:12:21 INFO - mozversion platform_changeset: 31348bf997584cddcac6d741c1070c03f4a5ca5c 10:12:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:12:21 INFO - mozversion platform_version: 49.0a2 10:12:21 INFO - using testdate: 1467738741 10:12:21 INFO - actual date: 1467738741 10:12:21 INFO - starting webserver on 'localhost:36939' 10:12:21 INFO - SUITE-START | Running 2 tests 10:12:21 INFO - TEST-START | dromaeo_css 10:12:21 INFO - operating with platform_type : linux_ 10:12:21 INFO - Initialising browser for dromaeo_css test... 10:12:21 INFO - TEST-INFO | started process 7625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoKJLNp/profile http://localhost:36939/getInfo.html) 10:12:25 INFO - PROCESS | 7625 | __metrics Screen width/height:1600/1200 10:12:25 INFO - PROCESS | 7625 | colorDepth:24 10:12:25 INFO - PROCESS | 7625 | Browser inner width/height: 1024/697 10:12:25 INFO - PROCESS | 7625 | __metrics 10:12:25 ERROR - PROCESS | 7625 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:12:26 INFO - TEST-INFO | 7625: exit 0 10:12:26 INFO - Browser initialized. 10:12:26 INFO - Running cycle 1/1 for dromaeo_css test... 10:12:26 INFO - TEST-INFO | started process 7720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoKJLNp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:38 INFO - PROCESS | 7720 | RSS: Main: 145088512 10:12:38 INFO - PROCESS | 7720 | 10:13:29 INFO - PROCESS | 7720 | 1467738809600 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] 10:15:37 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36939/tests/dromaeo/cssquery-ext.html) 10:15:38 INFO - PROCESS | 7720 | RSS: Main: 254148608 10:15:38 INFO - PROCESS | 7720 | 10:18:40 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36939/tests/dromaeo/cssquery-ext.html (next: http://localhost:36939/tests/dromaeo/cssquery-jquery.html) 10:18:41 INFO - PROCESS | 7720 | RSS: Main: 227053568 10:18:41 INFO - PROCESS | 7720 | 10:21:43 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36939/tests/dromaeo/cssquery-mootools.html) 10:21:43 INFO - PROCESS | 7720 | RSS: Main: 222699520 10:21:43 INFO - PROCESS | 7720 | 10:24:45 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36939/tests/dromaeo/cssquery-prototype.html) 10:24:46 INFO - PROCESS | 7720 | RSS: Main: 222134272 10:24:46 INFO - PROCESS | 7720 | 10:27:49 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36939/tests/dromaeo/cssquery-yui.html) 10:27:49 INFO - PROCESS | 7720 | RSS: Main: 218329088 10:27:49 INFO - PROCESS | 7720 | 10:30:52 INFO - PROCESS | 7720 | Cycle 1(1): loaded http://localhost:36939/tests/dromaeo/cssquery-yui.html (next: http://localhost:36939/tests/dromaeo/cssquery-dojo.html) 10:30:52 INFO - PROCESS | 7720 | RSS: Main: 261029888 10:30:52 INFO - PROCESS | 7720 | 10:30:52 INFO - PROCESS | 7720 | __start_tp_report 10:30:52 INFO - PROCESS | 7720 | _x_x_mozilla_page_load 10:30:52 INFO - PROCESS | 7720 | _x_x_mozilla_page_load_details 10:30:52 INFO - PROCESS | 7720 | |i|pagename|runs| 10:30:52 INFO - PROCESS | 7720 | |0;dojo.html;3362.6469220731838;3372.7133193678537;3396.881109161179;3405.489176623506;3414.0781988863023;5480.26016487774;5567.47109024643;5585.888282234363;5599.41206173352;5605.355384130826;5463.726813659311;5560.582956278275;5565.1374037024225;5578.553715702744;5597.244372009777;4945.851624451272;4983.8504844854715;5015.498450154973;5037.722925239111;5082.339295891529;4956.281339205831;5021.949780502185;5037.143685573461;5038.697678139323;5047.394312682465;4965.950340496603;4981.452040275567;5002.274670172823;5014.498550144993;5045.318881950926;5086.771095300684;5110.872228194287;5112.079825631385;5113.2074528447965;5127.9230811537855;4830.9275360869615;4903.117438861003;4970.055689418999;5022.096022715909;5040.47075057121;5341.198820177005;5356.250124982505;5368.865778355534;5404.405515393303;5420.430854760233;5961.493273071794;5973.850653733648;5974.492168165668;5976.013957696975;5990.2212712347555;5883.7058147092475;5943.821685349447;5966.582339236255;5998.940010599926;6005.849853753647;5632.098864181711;5635.5773317001385;5642.040853054949;5656.745446454878;5662;5841.269841269841;6106.969465152646;6109.602875813058;6118.019533855675;6118.418750218722;5778.94221057784;5865.501432378295;5884.941150588439;5901.203337549462;5917.467427931507;5955.821325360246;5959.731812068468;5964.314103878023;5978;5991.310999235056;5644.181593668895;5805.680687562224;5937.139114828412;5958.940410595926;5970.522358211333;5848.8537786554825;5925;5932.7923522677365;5934.43622855828;5955.166276721263;4571.382863313476;4571.794269257892;4579.152856721517;4591.816327346935;4601.74690392025;4017;4039.3738970459626;4075.2460794753065;4108.1783643271465;4151.8962025949595;5725.942740572625;5750.453706897838;5757.050086735641;5759.337676167211;5782.2483077199695;5947.940520594739;5961.642301461926;5962.940370596239;5964.343922168558;6012.098185272244;5498.972505137449;5617.269754931915;5627.071533197059;5671.914921276184;5679.716014199356;5098.235264710249;5110;5112.821051263188;5119.6160287978555;5126.897462050738;6170.5372097092895;6209.379062093754;6228.096925945803;6228.377162283826;6237.345078766755;5722.055860782924;5819.243498345188;5840.036393994943;5860;5874.765009399576;6188.9690551546955;6202.5658203925295;6204.5967012144065;6206.596571222856;6214.130021796862;5625.662460252398;5770.422957704364;5773.278340207474;5780.653160810365;5791.305043394819;5793.884122317446;5829.708514574169;5870.119482077552;5898.144769008555;5902.881942361215;5706.885862282648;5734.168545560787;5738.225339579103;5745.683987380567;5756.136579513107;5599.580031497735;5671.319441667027;5699.373068962494;5746.626469279484;5755.36690964002;5649.096144616841;5709.543236540983;5715.5713321500225;5722.284714410699;5746.5402767779315;5812.564057695605;5818.4763371296785;5853.2390789198835;5854.502367298657;5854.707264636836;5506.807261745819;5618.073017951992;5678.290213723285;5703.657780533182;5726.885462290647 10:30:52 INFO - PROCESS | 7720 | |1;ext.html;590.6869359239605;614.9938500614993;636.6752955992446;641.4355367276794;642.4025656139788;32497.837510812442;47221.527784722144;48090.51909480904;48104.27843582345;48257.27614085792;49241.75379123099;49583;49616.255756163686;49683;49804.50195498044;8191.262786349227;9018.819623607507;9225.907740922572;10657.467126643676;10954.780904381907;10883;10957.50691218893;11012.229143959927;11015.504302306415;11019.118470522379;11034.503447344889;11085.83371249432;11087.72280692981;11093.3898635575;11093.72265693356;8310.293625041879;10907.454627268606;11114.833277500844;11115.610953616584;11163.497642606102;10655.52050157737;10741.140708743282;10747.408892510908;11093.778124437466;11096.667099987013;45798.31302530465;46159.53840461586;46359;46383.07233855304;46391.768041159914;3520.489529018278;3555.768875023141;3566.554180727409;3586.4261718125235;3633.582138054131;36044;36129;36256.274874502626;36260;37558.24883502342;4708.882277943045;4736.83421080264;4780.784864681098;4863.902721945541;4997.075541024922;407777;407931;407941.9602901996;408019;408279;39399.606003940164;72090;73375.63312183405;73385.26614733892;73478.6326068377;40081;42203;42370.15259694851;42400.36399454011;42410.57589424128;16061.759073613905;17961.7305740414;18047.278108875762;18133.09334533268;18150.364737234133;14564.85435145656;14782.852171478147;14899.851001489846;15308.617284567976;15310.540683779505;9494.810103798023;9524.190443812353;9526.85709714355;9587.712368628952;9593.472359020181;3605.6394360563736;3682.7606205597085;3685.594584595692;3695.279420512974;3720.6465385788306;1040.1159014837328;1066.9466526673634;1130.9717257068476;1150.896419322265;1174.8002839517303;34231.4865277021;35890.820545897106;36133.45799813005;36291.4556281656;36578;1125.3135587291745;1171.9707007324885;1189.5776999165346;1210.5460452330376;1226.1845872494869;18412.34288914004;18509.90745046293;18755.812441875678;18847.246110155713;18864.15111319994;594031;595814;598914;598965;601985;65807.67096164488;66302.66848665726;66357;66413.33586664168;66557.6672116646;1322.6362750243568;1385.6674398144373;1440.7478691228994;1467;1481.3333999700178;34153;35947.46078808768;36047.81976090103;36102.8194859024;36664;55386.44613553974;55588.72205638946;55607.721961389936;55857.720711396185;56097.71951140218;463537;464308;464940;465534;466034;28785.424291513635;30389;30947.845260773553;30955.226119347197;31419;52403.73798130985;53106;53268.200976984604;53969.46030539802;54002.459975399746;44603.330950035124;44758.55241447544;45084.32373514334;45791.77104114591;46051.30923036224;42449.36325955175;44543.10913781641;44663.33005004862;45437;45756.31365529453;44475.77762111169;44700.55299446964;45588.31617525806;45865.54134458746;45891.54108459006;38519.22961540698;39363.80318098391;39781.80109099436;40192.1961560773;40265.79867100646;30324.54513182348;30415.929822457587;30469.847650761603;30892.53661195039;30917 10:30:52 INFO - PROCESS | 7720 | |2;jquery.html;425.5425417675999;436.5334340466649;439.79329715033936;447.1972808808189;449.48982904403493;18867.71698424523;19657.213711451543;20560.280390186326;20624.587508249864;20646.690299645517;17935.192916318763;18840.905795471037;19604.31384901529;19627.803721962777;19644.901775491104;5724.513416359614;5889.823305300826;5935.228420305354;5937.346891841894;5942.376050514698;5487.368952570446;5720.856978575548;5786.623869448494;5789.681567513785;5842.240508733858;5609.0184217761725;5772.45161709639;5824.475797178253;5843.474087332139;5856.619319744224;5747.195392645033;5759.1937128802;5784;5785.421457854223;5789.218455508494;5139.743012849342;5431.8098866539485;5434.673919564839;5500.642458240201;5505.944940550583;14420.351084201237;14488.855111448962;14582.343794529272;14814.185219812905;14839.10965342072;2118.5762847430574;2263.479399738053;2294.3346429535413;2315.3632750993443;2841.886324547036;10305;10734.838977415346;10772.08437282832;12796.872031279661;13445.596632100955;1819;1893.8390236829748;1965.6756635155182;2022.9291974780958;2049.3237231713497;57085;79117.20882791156;81931;82034;99446.50276748643;11533.480993355319;12085.879141208476;12230.633081007583;12332.50669973209;12613.22509048008;17145.142742863056;17294.394696185573;17325;17328.30686772515;17339.56651083733;8824.338174636929;9191.448513089235;9312.394694344846;9388.202002829836;9400.294977876687;8930.910690893137;9004.909950900537;9051.185393314634;9123.908760912438;9180.44917304964;5054.898902021939;5099.592032637454;5218.165093585008;5238;5320.467953204648;2062.9381118566466;2078.210280093585;2117.375374264565;2135.359392182339;2190.4304880730806;961.3318743473219;983.8229118758549;1071.5938092324088;1087.0922779479065;1091.6343025086526;19043.714344284846;20230.797692023185;20314.898425507778;20321;20438.69341959872;1002.0580654185043;1013.2350075692952;1030.7268573827942;1036.228010132441;1053.1522124689698;10718.249722519504;11358.602448914413;11377.203595748384;11384.601538946097;11390.088792896548;424549;512119;517450;519516;524543;79044.81432778513;101411;102627;104104.47947760213;104144.47927760312;1040.0847254416065;1063.234471180764;1090.7763908398758;1105.0717397386074;1109.6837401340579;17889.10554472245;18108.72836907474;18168.27326906909;18190.181441834884;18296.359627412978;42974.570254297054;43147.13705725805;43240.567594324915;43721.344179837964;45107.77446112748;57683.42316576948;58646.7067664659;62129.68935155295;62384.376156239676;63586;8071.636776344961;8378.03652579961;8523.573821309034;8546.273566746648;8658.91341086581;10421;13278.601641950758;13446.46214151423;13895.444182233003;14626.122432654074;11805.350705711267;12142.696432589257;12295.200811947196;12448.31534265624;12671.936640317108;12261.01911847068;12392.81410778857;12449.93775031119;12652.87347126517;12786.424610892718;12418.813717794059;12550.49798008106;12727.490900364252;12762;12777.488900443877;8466.280366168698;8509.36179786531;8656.177663121993;8684.565771711515;8795.12048795141;9751.366161199783;12546.623601291976;12589.74820503603;12695.36523173856;12868.099233053596 10:30:52 INFO - PROCESS | 7720 | |3;mootools.html;1392.7423426666073;1578.4396539228574;1596.1460618569065;1817.227678236749;1929.7684277886647;9145.634174633014;9592.808143837128;9600.32797704161;9907.157891579225;9913.355631883922;9590.712278631634;9767.413955162696;9771.706848794529;9793.951030244856;9796.804063918717;2161.373201771484;2367.5028244068767;2441.170002199252;2471.6292556116637;2482.342179322472;2482.044412901028;2494.713107992577;2494.825362224645;2495.4260520080393;2496.3259919821726;2421.285720712394;2434.318390850565;2452.9877350613224;2454.263720883737;2455.545724041049;2090.174381119457;2309.480366917447;2369.668246445499;2417.2506522977933;2419.2258477287273;2408.337707130536;2430.1858877276136;2450.8652024138664;2451.227863223097;2453.288546321565;9365.812683746288;9471.14759671626;9479.715608531755;9533.809323813484;9599.376040557412;5509.393966663663;5645.3790083091235;5646.745896434671;5647;5654.293213348332;3374.746893982961;3483.8083905385192;3514.5606799150105;3569.036360182762;3607.6753092221566;1206.4329765010432;1216.021103012075;1225.1607648760628;1320.2804471563022;1352.6550729563996;13727.313634318245;13969.860301396957;13970.091944023607;13981;13984.790228146587;4777.116233496814;4853.150698627726;4874.268859671007;4882.170031094723;4956;11590.884091159149;11644.88355116438;11671.649850504498;11676.357800321064;11693.12301577368;5687.601867869293;5693.5445164387575;5707.543396528268;5711.457411545896;5712.857178570569;4581.289900065429;4911.582515486224;5058.367704036996;5070.518300761421;5141.871453213699;4294.334378171388;4314.870553883326;4352.216601011848;4359.367891655756;4386.824527018884;1259.829922960407;1337.8595247499068;1343.6305016120646;1353.5668586052368;1357.1992524410448;1002.7142264454595;1010.3887148275188;1010.6008126789877;1018.5671089786811;1042.135027926819;6344.714487848058;6365.363463653597;6401.3598640135615;6462.127612772216;6595;459.5266875118566;460.3945811258185;471.3824889394835;479.4749749024812;484.9030193961222;4164.562720914321;4226.767527786002;4239.194553034975;4306.418633484503;4321.611055005064;11974.22167559106;12495.125341226027;12509.499620015098;12537.43581538833;12542;12243.938780306042;12342.629721108382;12381.876181238253;12386.690332741753;12404.81392779109;8780.824383512294;8789.780255493535;8790.42862213954;8900.910990890137;9161.587728552098;6391.48868090561;6503.252126005381;6504.642244676588;6583.901241481286;6628.038934354395;10682.305650132717;11073.889261107286;11193.048590869867;11197;11236.381998990135;11382.829257560978;11423.371714555447;11429.657110286706;11439.828402574134;11551.249168804;7842.215778422112;8242.546659933761;8459.619317130868;8639.784005399915;8801.735947921572;9510.524473776422;9543.856842147512;9544.141027307576;9592.424454532751;9596.520173991134;8478.83042339162;8601.655933762579;8655.783605409915;8763.430377025728;8811.074837142009;8174.182581741778;8342.499450033018;8355.791105222417;8368;8411.45325553837;7732.536047837148;7844.254795794391;7844.882326765217;7850.450468467153;7853.371730261451;5326.467353264643;5457.699826509422;5653.434656534314;5719.6568205906115;5919.260092488439;5554.1946417770005;5580.581456390868;5605.32736071674;5642.915356269741;5734 10:30:52 INFO - PROCESS | 7720 | |4;prototype.html;348.8308170537289;357.6391829090312;357.6512899922576;366.05922778459336;367.5919729100698;5378.811741589046;5425.240466334716;5425.321834770649;5432.636802990692;5437.71615921313;5318.574514038877;5327.840164795062;5359.946400535993;5373.838784836451;5402.621816472839;3912.960870391288;3967.424723415103;4186.392973018926;4242.787860606973;4243.6605071594195;4159.729617574848;4192.182524407742;4215.873523794276;4225.704200705952;4233.428487154241;4016.6786657067364;4184.665226781865;4188.685848561355;4190.97904510477;4203.747775133502;4081.6122568297583;4182.979085104555;4191.057012172268;4201.096764195698;4212.262854000538;3730.682891954187;3731.4589384539363;3731.70146388291;3735.300438300567;3736.6263373662687;5185.55922746567;5188.299579556749;5194.792208311701;5196.220566914955;5199.688018718889;4611.700239484423;4838;4846;4851.6172890725975;4886.267059941002;5567.331920169606;5588.497035266845;5595.4124816894455;5596.244506991586;5640.787230745368;4089.3457046872654;4104.076582768883;4104.835806567734;4105.404716316118;4116.855910043134;5479;5732.22614946981;5757.251557297524;5764.166829058671;5772.567057470665;4143.875683729493;4164.416981622575;4176.540580536139;4178.1643671265865;4185.748855068706;4234.70357075008;4244.724092934011;4273.957260427418;4274.722143060691;4278.652224549257;4738.289256611536;4751.619870410359;4761.381020467317;4787.42550893888;4806.711597304103;5548.722563871871;5591.245181900473;5597.832065038056;5618.763871948165;5635.098384258581;1427.9290532100924;1451.7459444597152;1451.898367114313;1464.809574755275;1472.0799500312305;921.9262459003263;942.835003874333;949.5679465843025;953.7377221264207;955.5699935029264;4955.306257124005;4957.82647607332;5002.399712034579;5004.774785134605;5020.297158397827;5089.6691715038405;5106.872328191825;5111.233315002779;5157.045946499909;5199.922001169985;4809.374781278411;4944.393072251532;4980.377452818398;5024.789092799229;5028;2731.508328500849;2736.835789852615;2738.8907492465187;2752.477029364414;2755.4626847764894;5346.422805272454;5361.222622719762;5371.186457615137;5388.8952764683145;5394.73026348681;4848.733319667452;5161.632167475622;5168.793248270027;5238.580913526908;5323.893522129536;5343.919841202385;5402.91895621566;5407.432219616962;5415.756290966916;5447.031367904501;5046.318746969112;5109.412417572027;5148.6910785353;5162;5358.249845021778;5711.200431939449;5736.541076713769;5741.282339707536;5752.798652047159;5775.711214439178;6065.60573562717;6078.5441091919165;6086.3305036446845;6086.513078953762;6101.7559297627595;4112.218678451085;4197.496300443844;4205.3271476563605;4209.17921005401;4210.4105425241105;5524.806631767869;5604.523615492729;5749.310082790092;5791.420857914175;5810.622309549865;5596.972015139898;5642.294713160855;5648.943510564842;5656.943430565641;5685.71571421419;5559.498935287369;5581.386047534686;5594.6363486374885;5621.775128994795;5622.915656265078;5336.9466305338;5609.49514543693;5609.625641717806;5618.185363122243;5622.297212848394;5620.831375058755;5647.29408823897;5655.604107712421;5679.346875109415;5709.371969083314;5471.452854714496;5496.258005169411;5568.220449137043;5585.888282234414;5594.580406469612 10:30:52 INFO - PROCESS | 7720 | |5;yui.html;782.3193821375404;822.6174828704651;834.236673443799;834.9896625083647;839.3327304792688;15740.055596664193;15965.84034159658;15979.600509987256;16751.07869067201;17562;15418.383264669399;15454.768178477332;15547.844521554782;15552.144632045261;15576.45482408116;729.2124505534038;846.3102571404286;879.1033146190881;881.4843316659761;898.290350623007;881.7531091294416;883.3507372081547;884.1997991817383;886.9113088691144;886.9600867960958;924.958376873039;929.251952178496;930.4603330068544;931.1991687149047;931.4457897550947;758.3326672528168;879.0857508191473;908.4821651658557;908.6410867707285;927.3276874266171;669.3072669786748;669.5580916595023;669.5614372585964;669.6317025635881;669.6651674162919;15478.5356439307;15533.456329028542;15540.844591554052;15561.610959725984;15563.455279065292;14385.78421323681;15003.249837508081;15021.924890375587;15174.924125379413;15348.539543813704;13291.800622990662;13441.932790336083;13556.254406007665;13594.11638243511;13663.180209187381;4753;4761.666683332168;4785.258284965836;4801.615870730368;4862.100511405401;80759.5962020192;82465;83023.16976830275;84546.57726711388;85419.57290213509;12230.938845305895;12279.754404911851;12282.38588070593;12365.039329259089;12372.257664540157;23366.64950025751;23372.64941025886;23393.883030584737;23415.41461463477;23446.882765586062;8363.945459877774;8548.801070597538;8754.08082151365;8803.427777194462;8893.599788009555;4641.559051890065;4749.525047495223;4764.95235047652;4826.0347930414055;4853.878653033632;3425.469052296898;3524.806135662563;3525.25969546393;3526.4710293455673;3527.2063785648024;604.5767962426319;606.169547719627;620.6958590290815;626.1765778001912;635.3106879036205;612.4627185763765;652.6769249221666;707.7699747582056;740.1599184925041;742.2651574940878;9534.666286680073;9786.266030047775;9857.11285984265;9979.301448898652;10022.498875056219;679.8980152976994;689.5896941319907;712.8324843661735;723.5803234124195;737.9372753315921;4455.576720211575;4516.458025036951;4693.741844198534;4696.60078893291;4951.3810773653295;72002.63998680077;115194;115976;116710.41644791722;117850;100739.49630251802;102127.48936255272;103562;103892.48053759683;105401.47299263607;89505;89939;90590.09409905816;90612.93701062264;91945.54027229821;9406.905930940604;9409.576569054547;9444.905550944677;9444.95277523608;9445.952770236105;50447;52218.955620888126;53268;53292.73353633207;54640.453595463536;70194;78361.60819195867;78426.6078669603;79163.20836791558;79748;11597.188196826479;11913.940430297793;11942.283462992249;12726.363681816058;12799.488020479077;14097.718045639234;14639;15256.694866102838;15883.52349429519;15896.920515397349;14886.25568721538;15374.9231253843;15435.61410964735;15946.282417291482;16017.839821601634;14787.408503659733;14848.703025939205;15182.950301709128;15237.92381038132;15368.308426121075;15114;15286.694266114839;15303.464378747136;15330;15525.223738812789;10666.73333166677;10781.137508999105;10948.726281843017;11108.722281942693;11148.944255278671;10888.893328804734;11265.324080555192;11283.323000619988;11284.943575282072;11291.491882865126 10:30:52 INFO - PROCESS | 7720 | __end_tp_report 10:30:52 INFO - PROCESS | 7720 | __start_cc_report 10:30:52 INFO - PROCESS | 7720 | _x_x_mozilla_cycle_collect,888 10:30:52 INFO - PROCESS | 7720 | __end_cc_report 10:30:52 INFO - PROCESS | 7720 | __startTimestamp1467739852478__endTimestamp 10:30:52 INFO - PROCESS | 7720 | 10:30:52 INFO - PROCESS | 7720 | ------- Summary: start ------- 10:30:52 INFO - PROCESS | 7720 | Number of tests: 6 10:30:52 INFO - PROCESS | 7720 | 10:30:52 INFO - PROCESS | 7720 | [#0] dojo.html Cycles:165 Average:5510.35 Median:5715.57 stddev:605.69 (10.6%) stddev-sans-first:583.64 10:30:52 INFO - PROCESS | 7720 | Values: 3362.6 3372.7 3396.9 3405.5 3414.1 5480.3 5567.5 5585.9 5599.4 5605.4 5463.7 5560.6 5565.1 5578.6 5597.2 4945.9 4983.9 5015.5 5037.7 5082.3 4956.3 5021.9 5037.1 5038.7 5047.4 4966.0 4981.5 5002.3 5014.5 5045.3 5086.8 5110.9 5112.1 5113.2 5127.9 4830.9 4903.1 4970.1 5022.1 5040.5 5341.2 5356.3 5368.9 5404.4 5420.4 5961.5 5973.9 5974.5 5976.0 5990.2 5883.7 5943.8 5966.6 5998.9 6005.8 5632.1 5635.6 5642.0 5656.7 5662.0 5841.3 6107.0 6109.6 6118.0 6118.4 5778.9 5865.5 5884.9 5901.2 5917.5 5955.8 5959.7 5964.3 5978.0 5991.3 5644.2 5805.7 5937.1 5958.9 5970.5 5848.9 5925.0 5932.8 5934.4 5955.2 4571.4 4571.8 4579.2 4591.8 4601.7 4017.0 4039.4 4075.2 4108.2 4151.9 5725.9 5750.5 5757.1 5759.3 5782.2 5947.9 5961.6 5962.9 5964.3 6012.1 5499.0 5617.3 5627.1 5671.9 5679.7 5098.2 5110.0 5112.8 5119.6 5126.9 6170.5 6209.4 6228.1 6228.4 6237.3 5722.1 5819.2 5840.0 5860.0 5874.8 6189.0 6202.6 6204.6 6206.6 6214.1 5625.7 5770.4 5773.3 5780.7 5791.3 5793.9 5829.7 5870.1 5898.1 5902.9 5706.9 5734.2 5738.2 5745.7 5756.1 5599.6 5671.3 5699.4 5746.6 5755.4 5649.1 5709.5 5715.6 5722.3 5746.5 5812.6 5818.5 5853.2 5854.5 5854.7 5506.8 5618.1 5678.3 5703.7 5726.9 10:30:52 INFO - PROCESS | 7720 | 10:30:52 INFO - PROCESS | 7720 | [#1] ext.html Cycles:180 Average:65813.19 Median:39931.40 stddev:131866.74 (330.2%) stddev-sans-first:132145.74 10:30:52 INFO - PROCESS | 7720 | Values: 590.7 615.0 636.7 641.4 642.4 32497.8 47221.5 48090.5 48104.3 48257.3 49241.8 49583.0 49616.3 49683.0 49804.5 8191.3 9018.8 9225.9 10657.5 10954.8 10883.0 10957.5 11012.2 11015.5 11019.1 11034.5 11085.8 11087.7 11093.4 11093.7 8310.3 10907.5 11114.8 11115.6 11163.5 10655.5 10741.1 10747.4 11093.8 11096.7 45798.3 46159.5 46359.0 46383.1 46391.8 3520.5 3555.8 3566.6 3586.4 3633.6 36044.0 36129.0 36256.3 36260.0 37558.2 4708.9 4736.8 4780.8 4863.9 4997.1 407777.0 407931.0 407942.0 408019.0 408279.0 39399.6 72090.0 73375.6 73385.3 73478.6 40081.0 42203.0 42370.2 42400.4 42410.6 16061.8 17961.7 18047.3 18133.1 18150.4 14564.9 14782.9 14899.9 15308.6 15310.5 9494.8 9524.2 9526.9 9587.7 9593.5 3605.6 3682.8 3685.6 3695.3 3720.6 1040.1 1066.9 1131.0 1150.9 1174.8 34231.5 35890.8 36133.5 36291.5 36578.0 1125.3 1172.0 1189.6 1210.5 1226.2 18412.3 18509.9 18755.8 18847.2 18864.2 594031.0 595814.0 598914.0 598965.0 601985.0 65807.7 66302.7 66357.0 66413.3 66557.7 1322.6 1385.7 1440.7 1467.0 1481.3 34153.0 35947.5 36047.8 36102.8 36664.0 55386.4 55588.7 55607.7 55857.7 56097.7 463537.0 464308.0 464940.0 465534.0 466034.0 28785.4 30389.0 30947.8 30955.2 31419.0 52403.7 53106.0 53268.2 53969.5 54002.5 44603.3 44758.6 45084.3 45791.8 46051.3 42449.4 44543.1 44663.3 45437.0 45756.3 44475.8 44700.6 45588.3 45865.5 45891.5 38519.2 39363.8 39781.8 40192.2 40265.8 30324.5 30415.9 30469.8 30892.5 30917.0 10:30:52 INFO - PROCESS | 7720 | 10:30:52 INFO - PROCESS | 7720 | [#2] jquery.html Cycles:180 Average:29679.16 Median:20635.64 stddev:82729.67 (400.9%) stddev-sans-first:82932.59 10:30:52 INFO - PROCESS | 7720 | Values: 425.5 436.5 439.8 447.2 449.5 18867.7 19657.2 20560.3 20624.6 20646.7 17935.2 18840.9 19604.3 19627.8 19644.9 5724.5 5889.8 5935.2 5937.3 5942.4 5487.4 5720.9 5786.6 5789.7 5842.2 5609.0 5772.5 5824.5 5843.5 5856.6 5747.2 5759.2 5784.0 5785.4 5789.2 5139.7 5431.8 5434.7 5500.6 5505.9 14420.4 14488.9 14582.3 14814.2 14839.1 2118.6 2263.5 2294.3 2315.4 2841.9 10305.0 10734.8 10772.1 12796.9 13445.6 1819.0 1893.8 1965.7 2022.9 2049.3 57085.0 79117.2 81931.0 82034.0 99446.5 11533.5 12085.9 12230.6 12332.5 12613.2 17145.1 17294.4 17325.0 17328.3 17339.6 8824.3 9191.4 9312.4 9388.2 9400.3 8930.9 9004.9 9051.2 9123.9 9180.4 5054.9 5099.6 5218.2 5238.0 5320.5 2062.9 2078.2 2117.4 2135.4 2190.4 961.3 983.8 1071.6 1087.1 1091.6 19043.7 20230.8 20314.9 20321.0 20438.7 1002.1 1013.2 1030.7 1036.2 1053.2 10718.2 11358.6 11377.2 11384.6 11390.1 424549.0 512119.0 517450.0 519516.0 524543.0 79044.8 101411.0 102627.0 104104.5 104144.5 1040.1 1063.2 1090.8 1105.1 1109.7 17889.1 18108.7 18168.3 18190.2 18296.4 42974.6 43147.1 43240.6 43721.3 45107.8 57683.4 58646.7 62129.7 62384.4 63586.0 8071.6 8378.0 8523.6 8546.3 8658.9 10421.0 13278.6 13446.5 13895.4 14626.1 11805.4 12142.7 12295.2 12448.3 12671.9 12261.0 12392.8 12449.9 12652.9 12786.4 12418.8 12550.5 12727.5 12762.0 12777.5 8466.3 8509.4 8656.2 8684.6 8795.1 9751.4 12546.6 12589.7 12695.4 12868.1 10:30:52 INFO - PROCESS | 7720 | 10:30:52 INFO - PROCESS | 7720 | [#3] mootools.html Cycles:180 Average:6351.65 Median:2520.41 stddev:3766.19 (149.4%) stddev-sans-first:3758.32 10:30:52 INFO - PROCESS | 7720 | Values: 1392.7 1578.4 1596.1 1817.2 1929.8 9145.6 9592.8 9600.3 9907.2 9913.4 9590.7 9767.4 9771.7 9794.0 9796.8 2161.4 2367.5 2441.2 2471.6 2482.3 2482.0 2494.7 2494.8 2495.4 2496.3 2421.3 2434.3 2453.0 2454.3 2455.5 2090.2 2309.5 2369.7 2417.3 2419.2 2408.3 2430.2 2450.9 2451.2 2453.3 9365.8 9471.1 9479.7 9533.8 9599.4 5509.4 5645.4 5646.7 5647.0 5654.3 3374.7 3483.8 3514.6 3569.0 3607.7 1206.4 1216.0 1225.2 1320.3 1352.7 13727.3 13969.9 13970.1 13981.0 13984.8 4777.1 4853.2 4874.3 4882.2 4956.0 11590.9 11644.9 11671.6 11676.4 11693.1 5687.6 5693.5 5707.5 5711.5 5712.9 4581.3 4911.6 5058.4 5070.5 5141.9 4294.3 4314.9 4352.2 4359.4 4386.8 1259.8 1337.9 1343.6 1353.6 1357.2 1002.7 1010.4 1010.6 1018.6 1042.1 6344.7 6365.4 6401.4 6462.1 6595.0 459.5 460.4 471.4 479.5 484.9 4164.6 4226.8 4239.2 4306.4 4321.6 11974.2 12495.1 12509.5 12537.4 12542.0 12243.9 12342.6 12381.9 12386.7 12404.8 8780.8 8789.8 8790.4 8900.9 9161.6 6391.5 6503.3 6504.6 6583.9 6628.0 10682.3 11073.9 11193.0 11197.0 11236.4 11382.8 11423.4 11429.7 11439.8 11551.2 7842.2 8242.5 8459.6 8639.8 8801.7 9510.5 9543.9 9544.1 9592.4 9596.5 8478.8 8601.7 8655.8 8763.4 8811.1 8174.2 8342.5 8355.8 8368.0 8411.5 7732.5 7844.3 7844.9 7850.5 7853.4 5326.5 5457.7 5653.4 5719.7 5919.3 5554.2 5580.6 5605.3 5642.9 5734.0 10:30:52 INFO - PROCESS | 7720 | 10:30:52 INFO - PROCESS | 7720 | [#4] prototype.html Cycles:180 Average:4631.77 Median:5177.18 stddev:1337.68 (25.8%) stddev-sans-first:1302.24 10:30:52 INFO - PROCESS | 7720 | Values: 348.8 357.6 357.7 366.1 367.6 5378.8 5425.2 5425.3 5432.6 5437.7 5318.6 5327.8 5359.9 5373.8 5402.6 3913.0 3967.4 4186.4 4242.8 4243.7 4159.7 4192.2 4215.9 4225.7 4233.4 4016.7 4184.7 4188.7 4191.0 4203.7 4081.6 4183.0 4191.1 4201.1 4212.3 3730.7 3731.5 3731.7 3735.3 3736.6 5185.6 5188.3 5194.8 5196.2 5199.7 4611.7 4838.0 4846.0 4851.6 4886.3 5567.3 5588.5 5595.4 5596.2 5640.8 4089.3 4104.1 4104.8 4105.4 4116.9 5479.0 5732.2 5757.3 5764.2 5772.6 4143.9 4164.4 4176.5 4178.2 4185.7 4234.7 4244.7 4274.0 4274.7 4278.7 4738.3 4751.6 4761.4 4787.4 4806.7 5548.7 5591.2 5597.8 5618.8 5635.1 1427.9 1451.7 1451.9 1464.8 1472.1 921.9 942.8 949.6 953.7 955.6 4955.3 4957.8 5002.4 5004.8 5020.3 5089.7 5106.9 5111.2 5157.0 5199.9 4809.4 4944.4 4980.4 5024.8 5028.0 2731.5 2736.8 2738.9 2752.5 2755.5 5346.4 5361.2 5371.2 5388.9 5394.7 4848.7 5161.6 5168.8 5238.6 5323.9 5343.9 5402.9 5407.4 5415.8 5447.0 5046.3 5109.4 5148.7 5162.0 5358.2 5711.2 5736.5 5741.3 5752.8 5775.7 6065.6 6078.5 6086.3 6086.5 6101.8 4112.2 4197.5 4205.3 4209.2 4210.4 5524.8 5604.5 5749.3 5791.4 5810.6 5597.0 5642.3 5648.9 5656.9 5685.7 5559.5 5581.4 5594.6 5621.8 5622.9 5336.9 5609.5 5609.6 5618.2 5622.3 5620.8 5647.3 5655.6 5679.3 5709.4 5471.5 5496.3 5568.2 5585.9 5594.6 10:30:52 INFO - PROCESS | 7720 | 10:30:52 INFO - PROCESS | 7720 | [#5] yui.html Cycles:180 Average:21505.01 Median:4751.26 stddev:30493.75 (641.8%) stddev-sans-first:30539.59 10:30:52 INFO - PROCESS | 7720 | Values: 782.3 822.6 834.2 835.0 839.3 15740.1 15965.8 15979.6 16751.1 17562.0 15418.4 15454.8 15547.8 15552.1 15576.5 729.2 846.3 879.1 881.5 898.3 881.8 883.4 884.2 886.9 887.0 925.0 929.3 930.5 931.2 931.4 758.3 879.1 908.5 908.6 927.3 669.3 669.6 669.6 669.6 669.7 15478.5 15533.5 15540.8 15561.6 15563.5 14385.8 15003.2 15021.9 15174.9 15348.5 13291.8 13441.9 13556.3 13594.1 13663.2 4753.0 4761.7 4785.3 4801.6 4862.1 80759.6 82465.0 83023.2 84546.6 85419.6 12230.9 12279.8 12282.4 12365.0 12372.3 23366.6 23372.6 23393.9 23415.4 23446.9 8363.9 8548.8 8754.1 8803.4 8893.6 4641.6 4749.5 4765.0 4826.0 4853.9 3425.5 3524.8 3525.3 3526.5 3527.2 604.6 606.2 620.7 626.2 635.3 612.5 652.7 707.8 740.2 742.3 9534.7 9786.3 9857.1 9979.3 10022.5 679.9 689.6 712.8 723.6 737.9 4455.6 4516.5 4693.7 4696.6 4951.4 72002.6 115194.0 115976.0 116710.4 117850.0 100739.5 102127.5 103562.0 103892.5 105401.5 89505.0 89939.0 90590.1 90612.9 91945.5 9406.9 9409.6 9444.9 9445.0 9446.0 50447.0 52219.0 53268.0 53292.7 54640.5 70194.0 78361.6 78426.6 79163.2 79748.0 11597.2 11913.9 11942.3 12726.4 12799.5 14097.7 14639.0 15256.7 15883.5 15896.9 14886.3 15374.9 15435.6 15946.3 16017.8 14787.4 14848.7 15183.0 15237.9 15368.3 15114.0 15286.7 15303.5 15330.0 15525.2 10666.7 10781.1 10948.7 11108.7 11148.9 10888.9 11265.3 11283.3 11284.9 11291.5 10:30:52 INFO - PROCESS | 7720 | -------- Summary: end -------- 10:30:52 INFO - PROCESS | 7720 | 10:30:53 INFO - TEST-INFO | 7720: exit 0 10:30:53 INFO - TEST-OK | dromaeo_css | took 1111773ms 10:30:53 INFO - TEST-START | kraken 10:30:53 INFO - operating with platform_type : linux_ 10:30:53 INFO - Initialising browser for kraken test... 10:30:53 INFO - TEST-INFO | started process 7916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5rzWS4/profile http://localhost:36939/getInfo.html) 10:30:56 INFO - PROCESS | 7916 | __metrics Screen width/height:1600/1200 10:30:56 INFO - PROCESS | 7916 | colorDepth:24 10:30:56 INFO - PROCESS | 7916 | Browser inner width/height: 1024/697 10:30:56 INFO - PROCESS | 7916 | __metrics 10:30:57 ERROR - PROCESS | 7916 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:30:58 INFO - TEST-INFO | 7916: exit 0 10:30:58 INFO - Browser initialized. 10:30:58 INFO - Running cycle 1/1 for kraken test... 10:30:58 INFO - TEST-INFO | started process 8007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5rzWS4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:10 INFO - PROCESS | 8007 | RSS: Main: 145330176 10:31:10 INFO - PROCESS | 8007 | 10:31:12 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36939/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:13 INFO - PROCESS | 8007 | RSS: Main: 194387968 10:31:13 INFO - PROCESS | 8007 | 10:31:16 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36939/tests/kraken/driver.html?testName=audio-dft) 10:31:16 INFO - PROCESS | 8007 | RSS: Main: 192012288 10:31:16 INFO - PROCESS | 8007 | 10:31:19 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36939/tests/kraken/driver.html?testName=audio-fft) 10:31:20 INFO - PROCESS | 8007 | RSS: Main: 278810624 10:31:20 INFO - PROCESS | 8007 | 10:31:22 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36939/tests/kraken/driver.html?testName=audio-oscillator) 10:31:22 INFO - PROCESS | 8007 | RSS: Main: 187744256 10:31:22 INFO - PROCESS | 8007 | 10:31:25 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:31:25 INFO - PROCESS | 8007 | RSS: Main: 188272640 10:31:25 INFO - PROCESS | 8007 | 10:31:28 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36939/tests/kraken/driver.html?testName=imaging-darkroom) 10:31:29 INFO - PROCESS | 8007 | RSS: Main: 222060544 10:31:29 INFO - PROCESS | 8007 | 10:31:32 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36939/tests/kraken/driver.html?testName=imaging-desaturate) 10:31:33 INFO - PROCESS | 8007 | RSS: Main: 222629888 10:31:33 INFO - PROCESS | 8007 | 10:31:35 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36939/tests/kraken/driver.html?testName=json-parse-financial) 10:31:36 INFO - PROCESS | 8007 | RSS: Main: 222371840 10:31:36 INFO - PROCESS | 8007 | 10:31:37 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:31:38 INFO - PROCESS | 8007 | RSS: Main: 201105408 10:31:38 INFO - PROCESS | 8007 | 10:31:40 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36939/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:31:40 INFO - PROCESS | 8007 | RSS: Main: 201289728 10:31:40 INFO - PROCESS | 8007 | 10:31:42 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:31:43 INFO - PROCESS | 8007 | RSS: Main: 207572992 10:31:43 INFO - PROCESS | 8007 | 10:31:46 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:31:46 INFO - PROCESS | 8007 | RSS: Main: 213565440 10:31:46 INFO - PROCESS | 8007 | 10:31:49 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:31:49 INFO - PROCESS | 8007 | RSS: Main: 213270528 10:31:49 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | Cycle 1(1): loaded http://localhost:36939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36939/tests/kraken/driver.html?testName=ai-astar) 10:31:51 INFO - PROCESS | 8007 | RSS: Main: 256233472 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | __start_tp_report 10:31:51 INFO - PROCESS | 8007 | _x_x_mozilla_page_load 10:31:51 INFO - PROCESS | 8007 | _x_x_mozilla_page_load_details 10:31:51 INFO - PROCESS | 8007 | |i|pagename|runs| 10:31:51 INFO - PROCESS | 8007 | |0;ai-astar;110;104;109;108;109;108;108;107;109;109 10:31:51 INFO - PROCESS | 8007 | |1;audio-beat-detection;151;123;132;173;130;127;159;136;163;129 10:31:51 INFO - PROCESS | 8007 | |2;audio-dft;161;161;160;161;161;161;161;160;161;161 10:31:51 INFO - PROCESS | 8007 | |3;audio-fft;74;76;75;105;76;74;76;75;97;75 10:31:51 INFO - PROCESS | 8007 | |4;audio-oscillator;85;84;114;85;85;84;123;85;86;122 10:31:51 INFO - PROCESS | 8007 | |5;imaging-gaussian-blur;117;117;117;118;116;117;117;117;116;116 10:31:51 INFO - PROCESS | 8007 | |6;imaging-darkroom;146;146;145;147;146;146;146;146;145;146 10:31:51 INFO - PROCESS | 8007 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 10:31:51 INFO - PROCESS | 8007 | |8;json-parse-financial;51;50;51;52;52;52;52;54;50;51 10:31:51 INFO - PROCESS | 8007 | |9;json-stringify-tinderbox;60;60;61;59;59;60;59;60;60;61 10:31:51 INFO - PROCESS | 8007 | |10;stanford-crypto-aes;76;76;76;76;77;78;76;78;112;82 10:31:51 INFO - PROCESS | 8007 | |11;stanford-crypto-ccm;124;118;119;127;127;118;117;122;127;118 10:31:51 INFO - PROCESS | 8007 | |12;stanford-crypto-pbkdf2;154;156;154;155;153;162;156;153;154;152 10:31:51 INFO - PROCESS | 8007 | |13;stanford-crypto-sha256-iterative;63;63;64;62;62;63;66;62;62;62 10:31:51 INFO - PROCESS | 8007 | __end_tp_report 10:31:51 INFO - PROCESS | 8007 | __start_cc_report 10:31:51 INFO - PROCESS | 8007 | _x_x_mozilla_cycle_collect,1584 10:31:51 INFO - PROCESS | 8007 | __end_cc_report 10:31:51 INFO - PROCESS | 8007 | __startTimestamp1467739911824__endTimestamp 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | ------- Summary: start ------- 10:31:51 INFO - PROCESS | 8007 | Number of tests: 14 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:1.66 (1.5%) stddev-sans-first:1.62 10:31:51 INFO - PROCESS | 8007 | Values: 110.0 104.0 109.0 108.0 109.0 108.0 108.0 107.0 109.0 109.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:143.50 stddev:17.66 (12.3%) stddev-sans-first:18.45 10:31:51 INFO - PROCESS | 8007 | Values: 151.0 123.0 132.0 173.0 130.0 127.0 159.0 136.0 163.0 129.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 10:31:51 INFO - PROCESS | 8007 | Values: 161.0 161.0 160.0 161.0 161.0 161.0 161.0 160.0 161.0 161.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.50 stddev:11.10 (14.7%) stddev-sans-first:11.53 10:31:51 INFO - PROCESS | 8007 | Values: 74.0 76.0 75.0 105.0 76.0 74.0 76.0 75.0 97.0 75.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:85.00 stddev:16.98 (20.0%) stddev-sans-first:17.60 10:31:51 INFO - PROCESS | 8007 | Values: 85.0 84.0 114.0 85.0 85.0 84.0 123.0 85.0 86.0 122.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:31:51 INFO - PROCESS | 8007 | Values: 117.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 116.0 116.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:31:51 INFO - PROCESS | 8007 | Values: 146.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:31:51 INFO - PROCESS | 8007 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.18 (2.3%) stddev-sans-first:1.24 10:31:51 INFO - PROCESS | 8007 | Values: 51.0 50.0 51.0 52.0 52.0 52.0 52.0 54.0 50.0 51.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 10:31:51 INFO - PROCESS | 8007 | Values: 60.0 60.0 61.0 59.0 59.0 60.0 59.0 60.0 60.0 61.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:76.50 stddev:11.16 (14.6%) stddev-sans-first:11.70 10:31:51 INFO - PROCESS | 8007 | Values: 76.0 76.0 76.0 76.0 77.0 78.0 76.0 78.0 112.0 82.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:123.00 stddev:4.22 (3.4%) stddev-sans-first:4.39 10:31:51 INFO - PROCESS | 8007 | Values: 124.0 118.0 119.0 127.0 127.0 118.0 117.0 122.0 127.0 118.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:154.50 stddev:2.81 (1.8%) stddev-sans-first:2.96 10:31:51 INFO - PROCESS | 8007 | Values: 154.0 156.0 154.0 155.0 153.0 162.0 156.0 153.0 154.0 152.0 10:31:51 INFO - PROCESS | 8007 | 10:31:51 INFO - PROCESS | 8007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.29 (2.0%) stddev-sans-first:1.36 10:31:51 INFO - PROCESS | 8007 | Values: 63.0 63.0 64.0 62.0 62.0 63.0 66.0 62.0 62.0 62.0 10:31:51 INFO - PROCESS | 8007 | -------- Summary: end -------- 10:31:51 INFO - PROCESS | 8007 | 10:31:52 INFO - TEST-INFO | 8007: exit 0 10:31:52 INFO - TEST-OK | kraken | took 59603ms 10:31:52 INFO - SUITE-END | took 1171s 10:31:52 INFO - Completed test suite (00:19:31) 10:31:52 INFO - javascript benchmark 10:31:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3362.6469220731838, 3372.7133193678537, 3396.881109161179, 3405.489176623506, 3414.0781988863023, 5480.26016487774, 5567.47109024643, 5585.888282234363, 5599.41206173352, 5605.355384130826, 5463.726813659311, 5560.582956278275, 5565.1374037024225, 5578.553715702744, 5597.244372009777, 4945.851624451272, 4983.8504844854715, 5015.498450154973, 5037.722925239111, 5082.339295891529, 4956.281339205831, 5021.949780502185, 5037.143685573461, 5038.697678139323, 5047.394312682465, 4965.950340496603, 4981.452040275567, 5002.274670172823, 5014.498550144993, 5045.318881950926, 5086.771095300684, 5110.872228194287, 5112.079825631385, 5113.2074528447965, 5127.9230811537855, 4830.9275360869615, 4903.117438861003, 4970.055689418999, 5022.096022715909, 5040.47075057121, 5341.198820177005, 5356.250124982505, 5368.865778355534, 5404.405515393303, 5420.430854760233, 5961.493273071794, 5973.850653733648, 5974.492168165668, 5976.013957696975, 5990.2212712347555, 5883.7058147092475, 5943.821685349447, 5966.582339236255, 5998.940010599926, 6005.849853753647, 5632.098864181711, 5635.5773317001385, 5642.040853054949, 5656.745446454878, 5662.0, 5841.269841269841, 6106.969465152646, 6109.602875813058, 6118.019533855675, 6118.418750218722, 5778.94221057784, 5865.501432378295, 5884.941150588439, 5901.203337549462, 5917.467427931507, 5955.821325360246, 5959.731812068468, 5964.314103878023, 5978.0, 5991.310999235056, 5644.181593668895, 5805.680687562224, 5937.139114828412, 5958.940410595926, 5970.522358211333, 5848.8537786554825, 5925.0, 5932.7923522677365, 5934.43622855828, 5955.166276721263, 4571.382863313476, 4571.794269257892, 4579.152856721517, 4591.816327346935, 4601.74690392025, 4017.0, 4039.3738970459626, 4075.2460794753065, 4108.1783643271465, 4151.8962025949595, 5725.942740572625, 5750.453706897838, 5757.050086735641, 5759.337676167211, 5782.2483077199695, 5947.940520594739, 5961.642301461926, 5962.940370596239, 5964.343922168558, 6012.098185272244, 5498.972505137449, 5617.269754931915, 5627.071533197059, 5671.914921276184, 5679.716014199356, 5098.235264710249, 5110.0, 5112.821051263188, 5119.6160287978555, 5126.897462050738, 6170.5372097092895, 6209.379062093754, 6228.096925945803, 6228.377162283826, 6237.345078766755, 5722.055860782924, 5819.243498345188, 5840.036393994943, 5860.0, 5874.765009399576, 6188.9690551546955, 6202.5658203925295, 6204.5967012144065, 6206.596571222856, 6214.130021796862, 5625.662460252398, 5770.422957704364, 5773.278340207474, 5780.653160810365, 5791.305043394819, 5793.884122317446, 5829.708514574169, 5870.119482077552, 5898.144769008555, 5902.881942361215, 5706.885862282648, 5734.168545560787, 5738.225339579103, 5745.683987380567, 5756.136579513107, 5599.580031497735, 5671.319441667027, 5699.373068962494, 5746.626469279484, 5755.36690964002, 5649.096144616841, 5709.543236540983, 5715.5713321500225, 5722.284714410699, 5746.5402767779315, 5812.564057695605, 5818.4763371296785, 5853.2390789198835, 5854.502367298657, 5854.707264636836, 5506.807261745819, 5618.073017951992, 5678.290213723285, 5703.657780533182, 5726.885462290647], "value": 5471.842880430922, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.6869359239605, 614.9938500614993, 636.6752955992446, 641.4355367276794, 642.4025656139788, 32497.837510812442, 47221.527784722144, 48090.51909480904, 48104.27843582345, 48257.27614085792, 49241.75379123099, 49583.0, 49616.255756163686, 49683.0, 49804.50195498044, 8191.262786349227, 9018.819623607507, 9225.907740922572, 10657.467126643676, 10954.780904381907, 10883.0, 10957.50691218893, 11012.229143959927, 11015.504302306415, 11019.118470522379, 11034.503447344889, 11085.83371249432, 11087.72280692981, 11093.3898635575, 11093.72265693356, 8310.293625041879, 10907.454627268606, 11114.833277500844, 11115.610953616584, 11163.497642606102, 10655.52050157737, 10741.140708743282, 10747.408892510908, 11093.778124437466, 11096.667099987013, 45798.31302530465, 46159.53840461586, 46359.0, 46383.07233855304, 46391.768041159914, 3520.489529018278, 3555.768875023141, 3566.554180727409, 3586.4261718125235, 3633.582138054131, 36044.0, 36129.0, 36256.274874502626, 36260.0, 37558.24883502342, 4708.882277943045, 4736.83421080264, 4780.784864681098, 4863.902721945541, 4997.075541024922, 407777.0, 407931.0, 407941.9602901996, 408019.0, 408279.0, 39399.606003940164, 72090.0, 73375.63312183405, 73385.26614733892, 73478.6326068377, 40081.0, 42203.0, 42370.15259694851, 42400.36399454011, 42410.57589424128, 16061.759073613905, 17961.7305740414, 18047.278108875762, 18133.09334533268, 18150.364737234133, 14564.85435145656, 14782.852171478147, 14899.851001489846, 15308.617284567976, 15310.540683779505, 9494.810103798023, 9524.190443812353, 9526.85709714355, 9587.712368628952, 9593.472359020181, 3605.6394360563736, 3682.7606205597085, 3685.594584595692, 3695.279420512974, 3720.6465385788306, 1040.1159014837328, 1066.9466526673634, 1130.9717257068476, 1150.896419322265, 1174.8002839517303, 34231.4865277021, 35890.820545897106, 36133.45799813005, 36291.4556281656, 36578.0, 1125.3135587291745, 1171.9707007324885, 1189.5776999165346, 1210.5460452330376, 1226.1845872494869, 18412.34288914004, 18509.90745046293, 18755.812441875678, 18847.246110155713, 18864.15111319994, 594031.0, 595814.0, 598914.0, 598965.0, 601985.0, 65807.67096164488, 66302.66848665726, 66357.0, 66413.33586664168, 66557.6672116646, 1322.6362750243568, 1385.6674398144373, 1440.7478691228994, 1467.0, 1481.3333999700178, 34153.0, 35947.46078808768, 36047.81976090103, 36102.8194859024, 36664.0, 55386.44613553974, 55588.72205638946, 55607.721961389936, 55857.720711396185, 56097.71951140218, 463537.0, 464308.0, 464940.0, 465534.0, 466034.0, 28785.424291513635, 30389.0, 30947.845260773553, 30955.226119347197, 31419.0, 52403.73798130985, 53106.0, 53268.200976984604, 53969.46030539802, 54002.459975399746, 44603.330950035124, 44758.55241447544, 45084.32373514334, 45791.77104114591, 46051.30923036224, 42449.36325955175, 44543.10913781641, 44663.33005004862, 45437.0, 45756.31365529453, 44475.77762111169, 44700.55299446964, 45588.31617525806, 45865.54134458746, 45891.54108459006, 38519.22961540698, 39363.80318098391, 39781.80109099436, 40192.1961560773, 40265.79867100646, 30324.54513182348, 30415.929822457587, 30469.847650761603, 30892.53661195039, 30917.0], "value": 21100.30298341486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.5425417675999, 436.5334340466649, 439.79329715033936, 447.1972808808189, 449.48982904403493, 18867.71698424523, 19657.213711451543, 20560.280390186326, 20624.587508249864, 20646.690299645517, 17935.192916318763, 18840.905795471037, 19604.31384901529, 19627.803721962777, 19644.901775491104, 5724.513416359614, 5889.823305300826, 5935.228420305354, 5937.346891841894, 5942.376050514698, 5487.368952570446, 5720.856978575548, 5786.623869448494, 5789.681567513785, 5842.240508733858, 5609.0184217761725, 5772.45161709639, 5824.475797178253, 5843.474087332139, 5856.619319744224, 5747.195392645033, 5759.1937128802, 5784.0, 5785.421457854223, 5789.218455508494, 5139.743012849342, 5431.8098866539485, 5434.673919564839, 5500.642458240201, 5505.944940550583, 14420.351084201237, 14488.855111448962, 14582.343794529272, 14814.185219812905, 14839.10965342072, 2118.5762847430574, 2263.479399738053, 2294.3346429535413, 2315.3632750993443, 2841.886324547036, 10305.0, 10734.838977415346, 10772.08437282832, 12796.872031279661, 13445.596632100955, 1819.0, 1893.8390236829748, 1965.6756635155182, 2022.9291974780958, 2049.3237231713497, 57085.0, 79117.20882791156, 81931.0, 82034.0, 99446.50276748643, 11533.480993355319, 12085.879141208476, 12230.633081007583, 12332.50669973209, 12613.22509048008, 17145.142742863056, 17294.394696185573, 17325.0, 17328.30686772515, 17339.56651083733, 8824.338174636929, 9191.448513089235, 9312.394694344846, 9388.202002829836, 9400.294977876687, 8930.910690893137, 9004.909950900537, 9051.185393314634, 9123.908760912438, 9180.44917304964, 5054.898902021939, 5099.592032637454, 5218.165093585008, 5238.0, 5320.467953204648, 2062.9381118566466, 2078.210280093585, 2117.375374264565, 2135.359392182339, 2190.4304880730806, 961.3318743473219, 983.8229118758549, 1071.5938092324088, 1087.0922779479065, 1091.6343025086526, 19043.714344284846, 20230.797692023185, 20314.898425507778, 20321.0, 20438.69341959872, 1002.0580654185043, 1013.2350075692952, 1030.7268573827942, 1036.228010132441, 1053.1522124689698, 10718.249722519504, 11358.602448914413, 11377.203595748384, 11384.601538946097, 11390.088792896548, 424549.0, 512119.0, 517450.0, 519516.0, 524543.0, 79044.81432778513, 101411.0, 102627.0, 104104.47947760213, 104144.47927760312, 1040.0847254416065, 1063.234471180764, 1090.7763908398758, 1105.0717397386074, 1109.6837401340579, 17889.10554472245, 18108.72836907474, 18168.27326906909, 18190.181441834884, 18296.359627412978, 42974.570254297054, 43147.13705725805, 43240.567594324915, 43721.344179837964, 45107.77446112748, 57683.42316576948, 58646.7067664659, 62129.68935155295, 62384.376156239676, 63586.0, 8071.636776344961, 8378.03652579961, 8523.573821309034, 8546.273566746648, 8658.91341086581, 10421.0, 13278.601641950758, 13446.46214151423, 13895.444182233003, 14626.122432654074, 11805.350705711267, 12142.696432589257, 12295.200811947196, 12448.31534265624, 12671.936640317108, 12261.01911847068, 12392.81410778857, 12449.93775031119, 12652.87347126517, 12786.424610892718, 12418.813717794059, 12550.49798008106, 12727.490900364252, 12762.0, 12777.488900443877, 8466.280366168698, 8509.36179786531, 8656.177663121993, 8684.565771711515, 8795.12048795141, 9751.366161199783, 12546.623601291976, 12589.74820503603, 12695.36523173856, 12868.099233053596], "value": 9523.063513198997, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.7423426666073, 1578.4396539228574, 1596.1460618569065, 1817.227678236749, 1929.7684277886647, 9145.634174633014, 9592.808143837128, 9600.32797704161, 9907.157891579225, 9913.355631883922, 9590.712278631634, 9767.413955162696, 9771.706848794529, 9793.951030244856, 9796.804063918717, 2161.373201771484, 2367.5028244068767, 2441.170002199252, 2471.6292556116637, 2482.342179322472, 2482.044412901028, 2494.713107992577, 2494.825362224645, 2495.4260520080393, 2496.3259919821726, 2421.285720712394, 2434.318390850565, 2452.9877350613224, 2454.263720883737, 2455.545724041049, 2090.174381119457, 2309.480366917447, 2369.668246445499, 2417.2506522977933, 2419.2258477287273, 2408.337707130536, 2430.1858877276136, 2450.8652024138664, 2451.227863223097, 2453.288546321565, 9365.812683746288, 9471.14759671626, 9479.715608531755, 9533.809323813484, 9599.376040557412, 5509.393966663663, 5645.3790083091235, 5646.745896434671, 5647.0, 5654.293213348332, 3374.746893982961, 3483.8083905385192, 3514.5606799150105, 3569.036360182762, 3607.6753092221566, 1206.4329765010432, 1216.021103012075, 1225.1607648760628, 1320.2804471563022, 1352.6550729563996, 13727.313634318245, 13969.860301396957, 13970.091944023607, 13981.0, 13984.790228146587, 4777.116233496814, 4853.150698627726, 4874.268859671007, 4882.170031094723, 4956.0, 11590.884091159149, 11644.88355116438, 11671.649850504498, 11676.357800321064, 11693.12301577368, 5687.601867869293, 5693.5445164387575, 5707.543396528268, 5711.457411545896, 5712.857178570569, 4581.289900065429, 4911.582515486224, 5058.367704036996, 5070.518300761421, 5141.871453213699, 4294.334378171388, 4314.870553883326, 4352.216601011848, 4359.367891655756, 4386.824527018884, 1259.829922960407, 1337.8595247499068, 1343.6305016120646, 1353.5668586052368, 1357.1992524410448, 1002.7142264454595, 1010.3887148275188, 1010.6008126789877, 1018.5671089786811, 1042.135027926819, 6344.714487848058, 6365.363463653597, 6401.3598640135615, 6462.127612772216, 6595.0, 459.5266875118566, 460.3945811258185, 471.3824889394835, 479.4749749024812, 484.9030193961222, 4164.562720914321, 4226.767527786002, 4239.194553034975, 4306.418633484503, 4321.611055005064, 11974.22167559106, 12495.125341226027, 12509.499620015098, 12537.43581538833, 12542.0, 12243.938780306042, 12342.629721108382, 12381.876181238253, 12386.690332741753, 12404.81392779109, 8780.824383512294, 8789.780255493535, 8790.42862213954, 8900.910990890137, 9161.587728552098, 6391.48868090561, 6503.252126005381, 6504.642244676588, 6583.901241481286, 6628.038934354395, 10682.305650132717, 11073.889261107286, 11193.048590869867, 11197.0, 11236.381998990135, 11382.829257560978, 11423.371714555447, 11429.657110286706, 11439.828402574134, 11551.249168804, 7842.215778422112, 8242.546659933761, 8459.619317130868, 8639.784005399915, 8801.735947921572, 9510.524473776422, 9543.856842147512, 9544.141027307576, 9592.424454532751, 9596.520173991134, 8478.83042339162, 8601.655933762579, 8655.783605409915, 8763.430377025728, 8811.074837142009, 8174.182581741778, 8342.499450033018, 8355.791105222417, 8368.0, 8411.45325553837, 7732.536047837148, 7844.254795794391, 7844.882326765217, 7850.450468467153, 7853.371730261451, 5326.467353264643, 5457.699826509422, 5653.434656534314, 5719.6568205906115, 5919.260092488439, 5554.1946417770005, 5580.581456390868, 5605.32736071674, 5642.915356269741, 5734.0], "value": 4922.635324839552, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.8308170537289, 357.6391829090312, 357.6512899922576, 366.05922778459336, 367.5919729100698, 5378.811741589046, 5425.240466334716, 5425.321834770649, 5432.636802990692, 5437.71615921313, 5318.574514038877, 5327.840164795062, 5359.946400535993, 5373.838784836451, 5402.621816472839, 3912.960870391288, 3967.424723415103, 4186.392973018926, 4242.787860606973, 4243.6605071594195, 4159.729617574848, 4192.182524407742, 4215.873523794276, 4225.704200705952, 4233.428487154241, 4016.6786657067364, 4184.665226781865, 4188.685848561355, 4190.97904510477, 4203.747775133502, 4081.6122568297583, 4182.979085104555, 4191.057012172268, 4201.096764195698, 4212.262854000538, 3730.682891954187, 3731.4589384539363, 3731.70146388291, 3735.300438300567, 3736.6263373662687, 5185.55922746567, 5188.299579556749, 5194.792208311701, 5196.220566914955, 5199.688018718889, 4611.700239484423, 4838.0, 4846.0, 4851.6172890725975, 4886.267059941002, 5567.331920169606, 5588.497035266845, 5595.4124816894455, 5596.244506991586, 5640.787230745368, 4089.3457046872654, 4104.076582768883, 4104.835806567734, 4105.404716316118, 4116.855910043134, 5479.0, 5732.22614946981, 5757.251557297524, 5764.166829058671, 5772.567057470665, 4143.875683729493, 4164.416981622575, 4176.540580536139, 4178.1643671265865, 4185.748855068706, 4234.70357075008, 4244.724092934011, 4273.957260427418, 4274.722143060691, 4278.652224549257, 4738.289256611536, 4751.619870410359, 4761.381020467317, 4787.42550893888, 4806.711597304103, 5548.722563871871, 5591.245181900473, 5597.832065038056, 5618.763871948165, 5635.098384258581, 1427.9290532100924, 1451.7459444597152, 1451.898367114313, 1464.809574755275, 1472.0799500312305, 921.9262459003263, 942.835003874333, 949.5679465843025, 953.7377221264207, 955.5699935029264, 4955.306257124005, 4957.82647607332, 5002.399712034579, 5004.774785134605, 5020.297158397827, 5089.6691715038405, 5106.872328191825, 5111.233315002779, 5157.045946499909, 5199.922001169985, 4809.374781278411, 4944.393072251532, 4980.377452818398, 5024.789092799229, 5028.0, 2731.508328500849, 2736.835789852615, 2738.8907492465187, 2752.477029364414, 2755.4626847764894, 5346.422805272454, 5361.222622719762, 5371.186457615137, 5388.8952764683145, 5394.73026348681, 4848.733319667452, 5161.632167475622, 5168.793248270027, 5238.580913526908, 5323.893522129536, 5343.919841202385, 5402.91895621566, 5407.432219616962, 5415.756290966916, 5447.031367904501, 5046.318746969112, 5109.412417572027, 5148.6910785353, 5162.0, 5358.249845021778, 5711.200431939449, 5736.541076713769, 5741.282339707536, 5752.798652047159, 5775.711214439178, 6065.60573562717, 6078.5441091919165, 6086.3305036446845, 6086.513078953762, 6101.7559297627595, 4112.218678451085, 4197.496300443844, 4205.3271476563605, 4209.17921005401, 4210.4105425241105, 5524.806631767869, 5604.523615492729, 5749.310082790092, 5791.420857914175, 5810.622309549865, 5596.972015139898, 5642.294713160855, 5648.943510564842, 5656.943430565641, 5685.71571421419, 5559.498935287369, 5581.386047534686, 5594.6363486374885, 5621.775128994795, 5622.915656265078, 5336.9466305338, 5609.49514543693, 5609.625641717806, 5618.185363122243, 5622.297212848394, 5620.831375058755, 5647.29408823897, 5655.604107712421, 5679.346875109415, 5709.371969083314, 5471.452854714496, 5496.258005169411, 5568.220449137043, 5585.888282234414, 5594.580406469612], "value": 4213.985520796995, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.3193821375404, 822.6174828704651, 834.236673443799, 834.9896625083647, 839.3327304792688, 15740.055596664193, 15965.84034159658, 15979.600509987256, 16751.07869067201, 17562.0, 15418.383264669399, 15454.768178477332, 15547.844521554782, 15552.144632045261, 15576.45482408116, 729.2124505534038, 846.3102571404286, 879.1033146190881, 881.4843316659761, 898.290350623007, 881.7531091294416, 883.3507372081547, 884.1997991817383, 886.9113088691144, 886.9600867960958, 924.958376873039, 929.251952178496, 930.4603330068544, 931.1991687149047, 931.4457897550947, 758.3326672528168, 879.0857508191473, 908.4821651658557, 908.6410867707285, 927.3276874266171, 669.3072669786748, 669.5580916595023, 669.5614372585964, 669.6317025635881, 669.6651674162919, 15478.5356439307, 15533.456329028542, 15540.844591554052, 15561.610959725984, 15563.455279065292, 14385.78421323681, 15003.249837508081, 15021.924890375587, 15174.924125379413, 15348.539543813704, 13291.800622990662, 13441.932790336083, 13556.254406007665, 13594.11638243511, 13663.180209187381, 4753.0, 4761.666683332168, 4785.258284965836, 4801.615870730368, 4862.100511405401, 80759.5962020192, 82465.0, 83023.16976830275, 84546.57726711388, 85419.57290213509, 12230.938845305895, 12279.754404911851, 12282.38588070593, 12365.039329259089, 12372.257664540157, 23366.64950025751, 23372.64941025886, 23393.883030584737, 23415.41461463477, 23446.882765586062, 8363.945459877774, 8548.801070597538, 8754.08082151365, 8803.427777194462, 8893.599788009555, 4641.559051890065, 4749.525047495223, 4764.95235047652, 4826.0347930414055, 4853.878653033632, 3425.469052296898, 3524.806135662563, 3525.25969546393, 3526.4710293455673, 3527.2063785648024, 604.5767962426319, 606.169547719627, 620.6958590290815, 626.1765778001912, 635.3106879036205, 612.4627185763765, 652.6769249221666, 707.7699747582056, 740.1599184925041, 742.2651574940878, 9534.666286680073, 9786.266030047775, 9857.11285984265, 9979.301448898652, 10022.498875056219, 679.8980152976994, 689.5896941319907, 712.8324843661735, 723.5803234124195, 737.9372753315921, 4455.576720211575, 4516.458025036951, 4693.741844198534, 4696.60078893291, 4951.3810773653295, 72002.63998680077, 115194.0, 115976.0, 116710.41644791722, 117850.0, 100739.49630251802, 102127.48936255272, 103562.0, 103892.48053759683, 105401.47299263607, 89505.0, 89939.0, 90590.09409905816, 90612.93701062264, 91945.54027229821, 9406.905930940604, 9409.576569054547, 9444.905550944677, 9444.95277523608, 9445.952770236105, 50447.0, 52218.955620888126, 53268.0, 53292.73353633207, 54640.453595463536, 70194.0, 78361.60819195867, 78426.6078669603, 79163.20836791558, 79748.0, 11597.188196826479, 11913.940430297793, 11942.283462992249, 12726.363681816058, 12799.488020479077, 14097.718045639234, 14639.0, 15256.694866102838, 15883.52349429519, 15896.920515397349, 14886.25568721538, 15374.9231253843, 15435.61410964735, 15946.282417291482, 16017.839821601634, 14787.408503659733, 14848.703025939205, 15182.950301709128, 15237.92381038132, 15368.308426121075, 15114.0, 15286.694266114839, 15303.464378747136, 15330.0, 15525.223738812789, 10666.73333166677, 10781.137508999105, 10948.726281843017, 11108.722281942693, 11148.944255278671, 10888.893328804734, 11265.324080555192, 11283.323000619988, 11284.943575282072, 11291.491882865126], "value": 7889.544192588337, "unit": "score"}], "name": "dromaeo_css", "value": 7513.883341964145, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 109.0, 108.0, 109.0, 108.0, 108.0, 107.0, 109.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 132.0, 173.0, 130.0, 127.0, 159.0, 136.0, 163.0, 129.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 105.0, 76.0, 74.0, 76.0, 75.0, 97.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 114.0, 85.0, 85.0, 84.0, 123.0, 85.0, 86.0, 122.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 52.0, 52.0, 52.0, 52.0, 54.0, 50.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 61.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 77.0, 78.0, 76.0, 78.0, 112.0, 82.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 118.0, 119.0, 127.0, 127.0, 118.0, 117.0, 122.0, 127.0, 118.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 154.0, 155.0, 153.0, 162.0, 156.0, 153.0, 154.0, 152.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 62.0, 62.0, 63.0, 66.0, 62.0, 62.0, 62.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1476.0000000000002, "alertThreshold": 2.0}]} 10:31:53 INFO - Return code: 0 10:31:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:31:53 ERROR - # TBPL SUCCESS # 10:31:53 INFO - Running post-action listener: _resource_record_post_action 10:31:53 INFO - ##### 10:31:53 INFO - ##### Finished run-tests step (success) 10:31:53 INFO - ##### 10:31:53 INFO - Running post-run listener: _resource_record_post_run 10:31:53 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 508891136; Read time: 164; Write time: 373656 10:31:53 INFO - TinderboxPrint: CPU usage
13.1% 10:31:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 164 10:31:53 INFO - TinderboxPrint: I/O write bytes / time
508,891,136 / 373,656 10:31:53 INFO - TinderboxPrint: CPU idle
8,245.6 (86.9%) 10:31:53 INFO - TinderboxPrint: CPU user
1,199.4 (12.6%) 10:31:53 INFO - TinderboxPrint: Swap in / out
0 / 0 10:31:53 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 252817408; Read time: 144; Write time: 229660 10:31:53 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 256073728; Read time: 20; Write time: 143996 10:31:53 INFO - Running post-run listener: _upload_blobber_files 10:31:53 INFO - Blob upload gear active. 10:31:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:31:53 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 10:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:31:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:31:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:57 INFO - (blobuploader) - INFO - Done attempting. 10:31:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:31:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:31:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:58 INFO - (blobuploader) - INFO - Done attempting. 10:31:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:31:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:31:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:58 INFO - (blobuploader) - INFO - Done attempting. 10:31:58 INFO - (blobuploader) - INFO - Iteration through files over. 10:31:58 INFO - Return code: 0 10:31:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:31:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:31:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5649871bcd87c3c9b56e607ae1a724a78c6f9783fcf261ca7be381c23c3da83c780acd1781bfb08c7e752a1f12806f4108ca4fe450edd66054d4a3145428f31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a617be946140af44943742822d6f73702c39bde646d0012c8ba06d2bcaf9a8b85be87de6d7a0a70001116066c80693b5c2c72a9c2653ffba0d1004bc0851454e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/547afe438b62da2d6db0d290e05af9018fd1014ea79d35ce4a1ffbf22767eac8eb45d72f11dd2431aa2296652f0224370dddf01bea295de3dabacc6af3ad5aaa"} 10:31:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:31:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:31:58 INFO - Contents: 10:31:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5649871bcd87c3c9b56e607ae1a724a78c6f9783fcf261ca7be381c23c3da83c780acd1781bfb08c7e752a1f12806f4108ca4fe450edd66054d4a3145428f31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a617be946140af44943742822d6f73702c39bde646d0012c8ba06d2bcaf9a8b85be87de6d7a0a70001116066c80693b5c2c72a9c2653ffba0d1004bc0851454e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/547afe438b62da2d6db0d290e05af9018fd1014ea79d35ce4a1ffbf22767eac8eb45d72f11dd2431aa2296652f0224370dddf01bea295de3dabacc6af3ad5aaa"} 10:31:58 INFO - Running post-run listener: copy_logs_to_upload_dir 10:31:58 INFO - Copying logs to upload dir... 10:31:58 INFO - mkdir: /builds/slave/test/build/upload/logs 10:31:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.353573 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-05 10:31:55.619048) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:31:55.622401) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5649871bcd87c3c9b56e607ae1a724a78c6f9783fcf261ca7be381c23c3da83c780acd1781bfb08c7e752a1f12806f4108ca4fe450edd66054d4a3145428f31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a617be946140af44943742822d6f73702c39bde646d0012c8ba06d2bcaf9a8b85be87de6d7a0a70001116066c80693b5c2c72a9c2653ffba0d1004bc0851454e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/547afe438b62da2d6db0d290e05af9018fd1014ea79d35ce4a1ffbf22767eac8eb45d72f11dd2431aa2296652f0224370dddf01bea295de3dabacc6af3ad5aaa"} build_url:https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/JJSa5Jn0Ry6TWlpHEljhEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5649871bcd87c3c9b56e607ae1a724a78c6f9783fcf261ca7be381c23c3da83c780acd1781bfb08c7e752a1f12806f4108ca4fe450edd66054d4a3145428f31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a617be946140af44943742822d6f73702c39bde646d0012c8ba06d2bcaf9a8b85be87de6d7a0a70001116066c80693b5c2c72a9c2653ffba0d1004bc0851454e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/547afe438b62da2d6db0d290e05af9018fd1014ea79d35ce4a1ffbf22767eac8eb45d72f11dd2431aa2296652f0224370dddf01bea295de3dabacc6af3ad5aaa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:31:55.647387) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:31:55.647684) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467738686.609309-447956290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:31:55.729518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:31:55.729788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:31:55.730046) ========= ========= Total master_lag: 0.15 =========