builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1468477361.0 results: success (0) buildid: 20160713152443 builduid: fb5f9fc9a81843ef95c1b9ce84958adb revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:40.999679) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:41.000412) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:41.000906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:41.017688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:41.018379) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 23:22:41-- 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% 42.6M=0s 2016-07-13 23:22:42 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106597 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:41.142487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:41.143037) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014611 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:41.193496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 23:22:41.193855) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --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 709652b674013b136627e45fd90b4e9063906a19 --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=97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 23:22:42,207 truncating revision to first 12 chars 2016-07-13 23:22:42,207 Setting DEBUG logging. 2016-07-13 23:22:42,207 attempt 1/10 2016-07-13 23:22:42,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/709652b67401?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 23:22:42,925 unpacking tar archive at: mozilla-aurora-709652b67401/testing/mozharness/ program finished with exit code 0 elapsedTime=1.086798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 23:22:42.295475) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:42.295819) ========= script_repo_revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:42.296216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:42.296483) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:42.307164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-13 23:22:42.307572) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:22:43 INFO - MultiFileLogger online at 20160713 23:22:43 in /builds/slave/test 23:22:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:22:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:22:43 INFO - {'append_to_log': False, 23:22:43 INFO - 'base_work_dir': '/builds/slave/test', 23:22:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:22:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:22:43 INFO - 'branch': 'Mozilla-Aurora', 23:22:43 INFO - 'buildbot_json_path': 'buildprops.json', 23:22:43 INFO - 'config_files': ('talos/linux_config.py',), 23:22:43 INFO - 'default_actions': ('clobber', 23:22:43 INFO - 'read-buildbot-config', 23:22:43 INFO - 'download-and-extract', 23:22:43 INFO - 'populate-webroot', 23:22:43 INFO - 'create-virtualenv', 23:22:43 INFO - 'install', 23:22:43 INFO - 'run-tests'), 23:22:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:22:43 INFO - 'download_minidump_stackwalk': True, 23:22:43 INFO - 'download_symbols': 'ondemand', 23:22:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:22:43 INFO - 'tooltool.py': '/tools/tooltool.py', 23:22:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:22:43 INFO - '/tools/misc-python/virtualenv.py')}, 23:22:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:22:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:22:43 INFO - 'installer_path': 'installer.exe', 23:22:43 INFO - 'log_level': 'info', 23:22:43 INFO - 'log_name': 'talos', 23:22:43 INFO - 'log_to_console': True, 23:22:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:22:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:22:43 INFO - 'opt_config_files': (), 23:22:43 INFO - 'pip_index': False, 23:22:43 INFO - 'sps_profile': False, 23:22:43 INFO - 'sps_profile_interval': 0, 23:22:43 INFO - 'suite': 'dromaeojs-e10s', 23:22:43 INFO - 'system_bits': '32', 23:22:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:22:43 INFO - 'title': 'talos-linux64-ix-068', 23:22:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:22:43 INFO - 'use_talos_json': True, 23:22:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:22:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:22:43 INFO - 'work_dir': 'build'} 23:22:43 INFO - ##### 23:22:43 INFO - ##### Running clobber step. 23:22:43 INFO - ##### 23:22:43 INFO - Running pre-action listener: _resource_record_pre_action 23:22:43 INFO - Running main action method: clobber 23:22:43 INFO - rmtree: /builds/slave/test/build 23:22:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:22:43 INFO - Running post-action listener: _resource_record_post_action 23:22:43 INFO - ##### 23:22:43 INFO - ##### Finished clobber step (success) 23:22:43 INFO - ##### 23:22:43 INFO - ##### 23:22:43 INFO - ##### Running read-buildbot-config step. 23:22:43 INFO - ##### 23:22:43 INFO - Running pre-action listener: _resource_record_pre_action 23:22:43 INFO - Running main action method: read_buildbot_config 23:22:43 INFO - Using buildbot properties: 23:22:43 INFO - { 23:22:43 INFO - "project": "", 23:22:43 INFO - "product": "firefox", 23:22:43 INFO - "script_repo_revision": "production", 23:22:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 23:22:43 INFO - "repository": "", 23:22:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 23:22:43 INFO - "buildid": "20160713152443", 23:22:43 INFO - "pgo_build": "True", 23:22:43 INFO - "basedir": "/builds/slave/test", 23:22:43 INFO - "buildnumber": 415, 23:22:43 INFO - "slavename": "talos-linux64-ix-068", 23:22:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:22:43 INFO - "platform": "ubuntu64_hw", 23:22:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:22:43 INFO - "branch": "mozilla-aurora", 23:22:43 INFO - "repo_path": "releases/mozilla-aurora", 23:22:43 INFO - "revision": "709652b674013b136627e45fd90b4e9063906a19", 23:22:43 INFO - "stage_platform": "linux64-pgo", 23:22:43 INFO - "builduid": "fb5f9fc9a81843ef95c1b9ce84958adb", 23:22:43 INFO - "slavebuilddir": "test" 23:22:43 INFO - } 23:22:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 23:22:43 INFO - Running post-action listener: _resource_record_post_action 23:22:43 INFO - ##### 23:22:43 INFO - ##### Finished read-buildbot-config step (success) 23:22:43 INFO - ##### 23:22:43 INFO - ##### 23:22:43 INFO - ##### Running download-and-extract step. 23:22:43 INFO - ##### 23:22:43 INFO - Running pre-action listener: _resource_record_pre_action 23:22:43 INFO - Running main action method: download_and_extract 23:22:43 INFO - mkdir: /builds/slave/test/build/tests 23:22:43 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')]} 23:22:43 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:44 INFO - Downloaded 1361 bytes. 23:22:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:44 INFO - Using the following test package requirements: 23:22:44 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:22:44 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:22:44 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:22:44 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:44 INFO - u'jsshell-linux-x86_64.zip'], 23:22:44 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:22:44 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:22:44 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:22:44 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:22:44 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:22:44 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:22:44 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:22: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')]} 23:22:44 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:45 INFO - Downloaded 24491003 bytes. 23:22:45 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'] 23:22:45 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 23:22:46 INFO - Return code: 0 23:22:46 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 23:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:46 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:47 INFO - Downloaded 24491003 bytes. 23:22:47 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'] 23:22:47 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 23:22:49 INFO - Return code: 0 23:22: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')]} 23:22:49 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:22:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:50 INFO - Downloaded 10833369 bytes. 23:22:50 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'] 23:22:50 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 23:22:50 INFO - Return code: 0 23:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:50 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:22:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:51 INFO - Downloaded 63642548 bytes. 23:22:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:51 INFO - mkdir: /builds/slave/test/properties 23:22:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:22:51 INFO - Writing to file /builds/slave/test/properties/build_url 23:22:51 INFO - Contents: 23:22:51 INFO - build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:52 INFO - Running post-action listener: _resource_record_post_action 23:22:52 INFO - Running post-action listener: set_extra_try_arguments 23:22:52 INFO - ##### 23:22:52 INFO - ##### Finished download-and-extract step (success) 23:22:52 INFO - ##### 23:22:52 INFO - ##### 23:22:52 INFO - ##### Running populate-webroot step. 23:22:52 INFO - ##### 23:22:52 INFO - Running pre-action listener: _resource_record_pre_action 23:22:52 INFO - Running main action method: populate_webroot 23:22:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:22:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:22:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:22:52 INFO - '--tppagecycles', 23:22:52 INFO - '7'], 23:22:52 INFO - 'tests': ['tsvgm']}}, 23:22:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:22:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:22:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:22:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:22:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:22:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:22:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:52 INFO - 'talos_options': ['--disable-e10s'], 23:22:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:52 INFO - 'talos_options': ['--disable-e10s'], 23:22:52 INFO - 'tests': ['damp', 'tps']}, 23:22:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:52 INFO - 'tests': ['damp', 'tps']}, 23:22:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:22:52 INFO - 'tests': ['dromaeo_dom']}, 23:22:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:22:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:22:52 INFO - 'tests': ['a11yr', 23:22:52 INFO - 'ts_paint', 23:22:52 INFO - 'tpaint', 23:22:52 INFO - 'sessionrestore', 23:22:52 INFO - 'sessionrestore_no_auto_restore', 23:22:52 INFO - 'tabpaint']}, 23:22:52 INFO - 'other-e10s': {'tests': ['a11yr', 23:22:52 INFO - 'ts_paint', 23:22:52 INFO - 'tpaint', 23:22:52 INFO - 'sessionrestore', 23:22:52 INFO - 'sessionrestore_no_auto_restore', 23:22:52 INFO - 'tabpaint']}, 23:22:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:22:52 INFO - 'ts_paint', 23:22:52 INFO - 'tpaint', 23:22:52 INFO - 'sessionrestore', 23:22:52 INFO - 'sessionrestore_no_auto_restore', 23:22:52 INFO - 'tabpaint']}, 23:22:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:22:52 INFO - 'ts_paint', 23:22:52 INFO - 'tpaint', 23:22:52 INFO - 'sessionrestore', 23:22:52 INFO - 'sessionrestore_no_auto_restore', 23:22:52 INFO - 'tabpaint']}, 23:22:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:22:52 INFO - 'tests': ['a11yr', 23:22:52 INFO - 'ts_paint', 23:22:52 INFO - 'tpaint', 23:22:52 INFO - 'sessionrestore', 23:22:52 INFO - 'sessionrestore_no_auto_restore', 23:22:52 INFO - 'tabpaint']}, 23:22:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:22:52 INFO - 'tests': ['a11yr', 23:22:52 INFO - 'ts_paint', 23:22:52 INFO - 'tpaint', 23:22:52 INFO - 'sessionrestore', 23:22:52 INFO - 'sessionrestore_no_auto_restore', 23:22:52 INFO - 'tabpaint']}, 23:22:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:22:52 INFO - 'tests': ['tsvgx', 23:22:52 INFO - 'tsvgr_opacity', 23:22:52 INFO - 'tart', 23:22:52 INFO - 'tscrollx', 23:22:52 INFO - 'cart']}, 23:22:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:22:52 INFO - 'tsvgr_opacity', 23:22:52 INFO - 'tart', 23:22:52 INFO - 'tscrollx', 23:22:52 INFO - 'cart']}, 23:22:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:52 INFO - 'talos_options': ['--disable-e10s'], 23:22:52 INFO - 'tests': ['tp5o']}, 23:22:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:52 INFO - 'tests': ['tp5o']}, 23:22:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:52 INFO - 'talos_options': ['--disable-e10s', 23:22:52 INFO - '--xperf_path', 23:22:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:52 INFO - 'tests': ['tp5n']}, 23:22:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:52 INFO - 'talos_options': ['--xperf_path', 23:22:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:52 INFO - 'tests': ['tp5n']}}, 23:22:52 INFO - 'talos.zip': {'path': '', 23:22:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:22:52 INFO - Running post-action listener: _resource_record_post_action 23:22:52 INFO - ##### 23:22:52 INFO - ##### Finished populate-webroot step (success) 23:22:52 INFO - ##### 23:22:52 INFO - ##### 23:22:52 INFO - ##### Running create-virtualenv step. 23:22:52 INFO - ##### 23:22:52 INFO - Running pre-action listener: _resource_record_pre_action 23:22:52 INFO - Running main action method: create_virtualenv 23:22:52 INFO - Creating virtualenv /builds/slave/test/build/venv 23:22:52 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 23:22:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:22:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:22:52 INFO - Using real prefix '/usr' 23:22:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:22:53 INFO - Installing distribute.............................................................................................................................................................................................done. 23:22:55 INFO - Installing pip.................done. 23:22:55 INFO - Return code: 0 23:22:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:22:55 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')]} 23:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:55 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')]} 23:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:55 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 0x7f0eeaf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1463450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', '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 23:22:55 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 23:22:55 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 23:22:55 INFO - Using env: {'DISPLAY': ':0', 23:22:55 INFO - 'HOME': '/home/cltbld', 23:22:55 INFO - 'LANG': 'en_US.UTF-8', 23:22:55 INFO - 'LANGUAGE': 'en_US:en', 23:22:55 INFO - 'LOGNAME': 'cltbld', 23:22:55 INFO - 'MAIL': '/var/mail/cltbld', 23:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:55 INFO - 'MOZ_NO_REMOTE': '1', 23:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:55 INFO - 'NO_EM_RESTART': '1', 23:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:55 INFO - 'PWD': '/builds/slave/test', 23:22:55 INFO - 'SHELL': '/bin/bash', 23:22:55 INFO - 'SHLVL': '1', 23:22:55 INFO - 'TERM': 'linux', 23:22:55 INFO - 'TMOUT': '86400', 23:22:55 INFO - 'USER': 'cltbld', 23:22:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:55 INFO - '_': '/tools/buildbot/bin/python'} 23:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:55 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 23:22:55 INFO - Cleaning up... 23:22:55 INFO - Return code: 0 23:22:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:22:55 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')]} 23:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:55 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')]} 23:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:55 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 0x7f0eeaf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1463450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', '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 23:22:55 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 23:22:55 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 23:22:55 INFO - Using env: {'DISPLAY': ':0', 23:22:55 INFO - 'HOME': '/home/cltbld', 23:22:55 INFO - 'LANG': 'en_US.UTF-8', 23:22:55 INFO - 'LANGUAGE': 'en_US:en', 23:22:55 INFO - 'LOGNAME': 'cltbld', 23:22:55 INFO - 'MAIL': '/var/mail/cltbld', 23:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:55 INFO - 'MOZ_NO_REMOTE': '1', 23:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:55 INFO - 'NO_EM_RESTART': '1', 23:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:55 INFO - 'PWD': '/builds/slave/test', 23:22:55 INFO - 'SHELL': '/bin/bash', 23:22:55 INFO - 'SHLVL': '1', 23:22:55 INFO - 'TERM': 'linux', 23:22:55 INFO - 'TMOUT': '86400', 23:22:55 INFO - 'USER': 'cltbld', 23:22:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:55 INFO - '_': '/tools/buildbot/bin/python'} 23:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:55 INFO - Downloading/unpacking psutil>=3.1.1 23:22:55 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 23:22:55 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 23:22:55 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 23:22:55 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 23:22:55 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 23:22:55 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 23:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:22:57 INFO - Installing collected packages: psutil 23:22:57 INFO - Running setup.py install for psutil 23:22:57 INFO - building 'psutil._psutil_linux' extension 23:22:57 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 23:22:58 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 23:22:58 INFO - building 'psutil._psutil_posix' extension 23:22:58 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 23:22:58 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 23:22:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:22:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:22:58 INFO - Successfully installed psutil 23:22:58 INFO - Cleaning up... 23:22:58 INFO - Return code: 0 23:22:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0eeaf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1463450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', '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 23:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:22:58 INFO - Using env: {'DISPLAY': ':0', 23:22:58 INFO - 'HOME': '/home/cltbld', 23:22:58 INFO - 'LANG': 'en_US.UTF-8', 23:22:58 INFO - 'LANGUAGE': 'en_US:en', 23:22:58 INFO - 'LOGNAME': 'cltbld', 23:22:58 INFO - 'MAIL': '/var/mail/cltbld', 23:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:58 INFO - 'MOZ_NO_REMOTE': '1', 23:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:58 INFO - 'NO_EM_RESTART': '1', 23:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:58 INFO - 'PWD': '/builds/slave/test', 23:22:58 INFO - 'SHELL': '/bin/bash', 23:22:58 INFO - 'SHLVL': '1', 23:22:58 INFO - 'TERM': 'linux', 23:22:58 INFO - 'TMOUT': '86400', 23:22:58 INFO - 'USER': 'cltbld', 23:22:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:58 INFO - '_': '/tools/buildbot/bin/python'} 23:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:23:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:23:00 INFO - Installing collected packages: mozsystemmonitor 23:23:00 INFO - Running setup.py install for mozsystemmonitor 23:23:00 INFO - Successfully installed mozsystemmonitor 23:23:00 INFO - Cleaning up... 23:23:00 INFO - Return code: 0 23:23:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:23: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')]} 23:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23: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')]} 23:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0eeaf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1463450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', '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 23:23: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==2.5.1'] in /builds/slave/test/build 23:23: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==2.5.1 23:23:00 INFO - Using env: {'DISPLAY': ':0', 23:23:00 INFO - 'HOME': '/home/cltbld', 23:23:00 INFO - 'LANG': 'en_US.UTF-8', 23:23:00 INFO - 'LANGUAGE': 'en_US:en', 23:23:00 INFO - 'LOGNAME': 'cltbld', 23:23:00 INFO - 'MAIL': '/var/mail/cltbld', 23:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:00 INFO - 'MOZ_NO_REMOTE': '1', 23:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:00 INFO - 'NO_EM_RESTART': '1', 23:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:00 INFO - 'PWD': '/builds/slave/test', 23:23:00 INFO - 'SHELL': '/bin/bash', 23:23:00 INFO - 'SHLVL': '1', 23:23:00 INFO - 'TERM': 'linux', 23:23:00 INFO - 'TMOUT': '86400', 23:23:00 INFO - 'USER': 'cltbld', 23:23:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:00 INFO - '_': '/tools/buildbot/bin/python'} 23:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:00 INFO - Downloading/unpacking jsonschema==2.5.1 23:23:00 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 23:23:00 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 23:23:00 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 23:23:00 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 23:23:00 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 23:23:00 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 23:23:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:23:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:02 INFO - Downloading functools32-3.2.3-2.tar.gz 23:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:23:03 INFO - warning: no files found matching '*.txt' 23:23:03 INFO - no previously-included directories found matching 'build' 23:23:03 INFO - no previously-included directories found matching 'dist' 23:23:03 INFO - no previously-included directories found matching '.git*' 23:23:03 INFO - Installing collected packages: jsonschema, functools32 23:23:03 INFO - Running setup.py install for functools32 23:23:03 INFO - warning: no files found matching '*.txt' 23:23:03 INFO - no previously-included directories found matching 'build' 23:23:03 INFO - no previously-included directories found matching 'dist' 23:23:03 INFO - no previously-included directories found matching '.git*' 23:23:03 INFO - Successfully installed jsonschema functools32 23:23:03 INFO - Cleaning up... 23:23:03 INFO - Return code: 0 23:23:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0eeaf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1463450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', '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 23:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:23:03 INFO - Using env: {'DISPLAY': ':0', 23:23:03 INFO - 'HOME': '/home/cltbld', 23:23:03 INFO - 'LANG': 'en_US.UTF-8', 23:23:03 INFO - 'LANGUAGE': 'en_US:en', 23:23:03 INFO - 'LOGNAME': 'cltbld', 23:23:03 INFO - 'MAIL': '/var/mail/cltbld', 23:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:03 INFO - 'MOZ_NO_REMOTE': '1', 23:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:03 INFO - 'NO_EM_RESTART': '1', 23:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:03 INFO - 'PWD': '/builds/slave/test', 23:23:03 INFO - 'SHELL': '/bin/bash', 23:23:03 INFO - 'SHLVL': '1', 23:23:03 INFO - 'TERM': 'linux', 23:23:03 INFO - 'TMOUT': '86400', 23:23:03 INFO - 'USER': 'cltbld', 23:23:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:03 INFO - '_': '/tools/buildbot/bin/python'} 23:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:03 INFO - Downloading/unpacking blobuploader==1.2.4 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:05 INFO - Downloading blobuploader-1.2.4.tar.gz 23:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:23:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:23:05 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 23:23:05 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 23:23:05 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 23:23:05 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 23:23:05 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 23:23:05 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 23:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:23:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:23:05 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 23:23:05 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 23:23:05 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 23:23:05 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 23:23:05 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 23:23:05 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 23:23:06 INFO - Downloading docopt-0.6.1.tar.gz 23:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:23:06 INFO - Installing collected packages: blobuploader, requests, docopt 23:23:06 INFO - Running setup.py install for blobuploader 23:23:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:23:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:23:06 INFO - Running setup.py install for requests 23:23:06 INFO - Running setup.py install for docopt 23:23:06 INFO - Successfully installed blobuploader requests docopt 23:23:06 INFO - Cleaning up... 23:23:06 INFO - Return code: 0 23:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:06 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 0x7f0eeaf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1463450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', '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 23:23:06 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 23:23:06 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 23:23:06 INFO - Using env: {'DISPLAY': ':0', 23:23:06 INFO - 'HOME': '/home/cltbld', 23:23:06 INFO - 'LANG': 'en_US.UTF-8', 23:23:06 INFO - 'LANGUAGE': 'en_US:en', 23:23:06 INFO - 'LOGNAME': 'cltbld', 23:23:06 INFO - 'MAIL': '/var/mail/cltbld', 23:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:06 INFO - 'MOZ_NO_REMOTE': '1', 23:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:06 INFO - 'NO_EM_RESTART': '1', 23:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:06 INFO - 'PWD': '/builds/slave/test', 23:23:06 INFO - 'SHELL': '/bin/bash', 23:23:06 INFO - 'SHLVL': '1', 23:23:06 INFO - 'TERM': 'linux', 23:23:06 INFO - 'TMOUT': '86400', 23:23:06 INFO - 'USER': 'cltbld', 23:23:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:06 INFO - '_': '/tools/buildbot/bin/python'} 23:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:06 INFO - Running setup.py (path:/tmp/pip-6NEUy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:07 INFO - Running setup.py (path:/tmp/pip-TbKmb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:07 INFO - Running setup.py (path:/tmp/pip-TfAJgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:07 INFO - Running setup.py (path:/tmp/pip-mnFg0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:07 INFO - Running setup.py (path:/tmp/pip-EZbBsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:07 INFO - Running setup.py (path:/tmp/pip-wsWhVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:07 INFO - Running setup.py (path:/tmp/pip-dQ1m59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:07 INFO - Running setup.py (path:/tmp/pip-Y3LkFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:07 INFO - Running setup.py (path:/tmp/pip-0RQy3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:07 INFO - Running setup.py (path:/tmp/pip-u_2tyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:07 INFO - Running setup.py (path:/tmp/pip-l2E4vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:07 INFO - Running setup.py (path:/tmp/pip-nVe8ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:07 INFO - Running setup.py (path:/tmp/pip-vv_ECI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:07 INFO - Running setup.py (path:/tmp/pip-mQr4Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:08 INFO - Running setup.py (path:/tmp/pip-MaziGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:08 INFO - Running setup.py (path:/tmp/pip-nhzhkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:08 INFO - Running setup.py (path:/tmp/pip-C1ip8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:23:08 INFO - Running setup.py install for manifestparser 23:23:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:23:08 INFO - Running setup.py install for mozcrash 23:23:08 INFO - Running setup.py install for mozdebug 23:23:08 INFO - Running setup.py install for mozdevice 23:23:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:23:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:23:08 INFO - Running setup.py install for mozfile 23:23:08 INFO - Running setup.py install for mozhttpd 23:23:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:23:08 INFO - Running setup.py install for mozinfo 23:23:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:23:08 INFO - Running setup.py install for mozInstall 23:23:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:23:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:23:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:23:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:23:09 INFO - Running setup.py install for mozleak 23:23:09 INFO - Running setup.py install for mozlog 23:23:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:23:09 INFO - Running setup.py install for moznetwork 23:23:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:23:09 INFO - Running setup.py install for mozprocess 23:23:09 INFO - Running setup.py install for mozprofile 23:23:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:23:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:23:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:23:09 INFO - Running setup.py install for mozrunner 23:23:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:23:09 INFO - Running setup.py install for mozscreenshot 23:23:09 INFO - Running setup.py install for moztest 23:23:09 INFO - Running setup.py install for mozversion 23:23:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:23:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:23:10 INFO - Cleaning up... 23:23:10 INFO - Return code: 0 23:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:10 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 0x7f0eeaf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1463450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', '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 23:23:10 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 23:23:10 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 23:23:10 INFO - Using env: {'DISPLAY': ':0', 23:23:10 INFO - 'HOME': '/home/cltbld', 23:23:10 INFO - 'LANG': 'en_US.UTF-8', 23:23:10 INFO - 'LANGUAGE': 'en_US:en', 23:23:10 INFO - 'LOGNAME': 'cltbld', 23:23:10 INFO - 'MAIL': '/var/mail/cltbld', 23:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:10 INFO - 'MOZ_NO_REMOTE': '1', 23:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:10 INFO - 'NO_EM_RESTART': '1', 23:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:10 INFO - 'PWD': '/builds/slave/test', 23:23:10 INFO - 'SHELL': '/bin/bash', 23:23:10 INFO - 'SHLVL': '1', 23:23:10 INFO - 'TERM': 'linux', 23:23:10 INFO - 'TMOUT': '86400', 23:23:10 INFO - 'USER': 'cltbld', 23:23:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:10 INFO - '_': '/tools/buildbot/bin/python'} 23:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:10 INFO - Running setup.py (path:/tmp/pip-5QN2wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:10 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)) 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:10 INFO - Running setup.py (path:/tmp/pip-NVmxfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:10 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)) 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:10 INFO - Running setup.py (path:/tmp/pip-uQhB5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:10 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)) 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:10 INFO - Running setup.py (path:/tmp/pip-JC75aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:10 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)) 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:10 INFO - Running setup.py (path:/tmp/pip-RKgw3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:10 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)) 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:10 INFO - Running setup.py (path:/tmp/pip-Nwluw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:10 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)) 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:10 INFO - Running setup.py (path:/tmp/pip-4Pheyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:10 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)) 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:10 INFO - Running setup.py (path:/tmp/pip-1IheAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:10 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)) 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:10 INFO - Running setup.py (path:/tmp/pip-Blge7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:10 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)) 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:10 INFO - Running setup.py (path:/tmp/pip-ZxU48o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:10 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)) 23:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:10 INFO - Running setup.py (path:/tmp/pip-aDEGko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:11 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)) 23:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:11 INFO - Running setup.py (path:/tmp/pip-7t19jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:11 INFO - Running setup.py (path:/tmp/pip-eu5wHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:11 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)) 23:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:11 INFO - Running setup.py (path:/tmp/pip-cmHzcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:11 INFO - Running setup.py (path:/tmp/pip-sgHTrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:11 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)) 23:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:11 INFO - Running setup.py (path:/tmp/pip-oB_E5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:11 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)) 23:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:11 INFO - Running setup.py (path:/tmp/pip-gpgxFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:11 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)) 23:23:11 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)) 23:23:11 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)) 23:23:11 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)) 23:23:11 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)) 23:23:11 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)) 23:23:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:13 INFO - Downloading blessings-1.6.tar.gz 23:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:23:13 INFO - Installing collected packages: blessings 23:23:13 INFO - Running setup.py install for blessings 23:23:13 INFO - Successfully installed blessings 23:23:13 INFO - Cleaning up... 23:23:13 INFO - Return code: 0 23:23:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:13 INFO - Reading from file tmpfile_stdout 23:23:13 INFO - Current package versions: 23:23:13 INFO - argparse == 1.2.1 23:23:13 INFO - blessings == 1.6 23:23:13 INFO - blobuploader == 1.2.4 23:23:13 INFO - docopt == 0.6.1 23:23:13 INFO - functools32 == 3.2.3-2 23:23:13 INFO - jsonschema == 2.5.1 23:23:13 INFO - manifestparser == 1.1 23:23:13 INFO - mozInstall == 1.12 23:23:13 INFO - mozcrash == 0.17 23:23:13 INFO - mozdebug == 0.1 23:23:13 INFO - mozdevice == 0.48 23:23:13 INFO - mozfile == 1.2 23:23:13 INFO - mozhttpd == 0.7 23:23:13 INFO - mozinfo == 0.9 23:23:13 INFO - mozleak == 0.1 23:23:13 INFO - mozlog == 3.2 23:23:13 INFO - moznetwork == 0.27 23:23:13 INFO - mozprocess == 0.23 23:23:13 INFO - mozprofile == 0.28 23:23:13 INFO - mozrunner == 6.12 23:23:13 INFO - mozscreenshot == 0.1 23:23:13 INFO - mozsystemmonitor == 0.3 23:23:13 INFO - moztest == 0.7 23:23:13 INFO - mozversion == 1.4 23:23:13 INFO - psutil == 3.1.1 23:23:13 INFO - requests == 1.2.3 23:23:13 INFO - wsgiref == 0.1.2 23:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:13 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 0x7f0eeaf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1463450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', '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 23:23:13 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 23:23:13 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 23:23:13 INFO - Using env: {'DISPLAY': ':0', 23:23:13 INFO - 'HOME': '/home/cltbld', 23:23:13 INFO - 'LANG': 'en_US.UTF-8', 23:23:13 INFO - 'LANGUAGE': 'en_US:en', 23:23:13 INFO - 'LOGNAME': 'cltbld', 23:23:13 INFO - 'MAIL': '/var/mail/cltbld', 23:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:13 INFO - 'MOZ_NO_REMOTE': '1', 23:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:13 INFO - 'NO_EM_RESTART': '1', 23:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:13 INFO - 'PWD': '/builds/slave/test', 23:23:13 INFO - 'SHELL': '/bin/bash', 23:23:13 INFO - 'SHLVL': '1', 23:23:13 INFO - 'TERM': 'linux', 23:23:13 INFO - 'TMOUT': '86400', 23:23:13 INFO - 'USER': 'cltbld', 23:23:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:13 INFO - '_': '/tools/buildbot/bin/python'} 23:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:14 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)) 23:23:14 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)) 23:23:14 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)) 23:23:14 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)) 23:23:14 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)) 23:23:14 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)) 23:23:14 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)) 23:23:14 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)) 23:23:14 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)) 23:23:14 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)) 23:23:14 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)) 23:23:14 INFO - Cleaning up... 23:23:14 INFO - Return code: 0 23:23:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0eeaf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1463450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', '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 23:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:23:14 INFO - Using env: {'DISPLAY': ':0', 23:23:14 INFO - 'HOME': '/home/cltbld', 23:23:14 INFO - 'LANG': 'en_US.UTF-8', 23:23:14 INFO - 'LANGUAGE': 'en_US:en', 23:23:14 INFO - 'LOGNAME': 'cltbld', 23:23:14 INFO - 'MAIL': '/var/mail/cltbld', 23:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:14 INFO - 'MOZ_NO_REMOTE': '1', 23:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:14 INFO - 'NO_EM_RESTART': '1', 23:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:14 INFO - 'PWD': '/builds/slave/test', 23:23:14 INFO - 'SHELL': '/bin/bash', 23:23:14 INFO - 'SHLVL': '1', 23:23:14 INFO - 'TERM': 'linux', 23:23:14 INFO - 'TMOUT': '86400', 23:23:14 INFO - 'USER': 'cltbld', 23:23:14 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:14 INFO - '_': '/tools/buildbot/bin/python'} 23:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:23:14 INFO - Cleaning up... 23:23:14 INFO - Return code: 0 23:23:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0eeaf03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1463450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', '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 23:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:23:14 INFO - Using env: {'DISPLAY': ':0', 23:23:14 INFO - 'HOME': '/home/cltbld', 23:23:14 INFO - 'LANG': 'en_US.UTF-8', 23:23:14 INFO - 'LANGUAGE': 'en_US:en', 23:23:14 INFO - 'LOGNAME': 'cltbld', 23:23:14 INFO - 'MAIL': '/var/mail/cltbld', 23:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:14 INFO - 'MOZ_NO_REMOTE': '1', 23:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:14 INFO - 'NO_EM_RESTART': '1', 23:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:14 INFO - 'PWD': '/builds/slave/test', 23:23:14 INFO - 'SHELL': '/bin/bash', 23:23:14 INFO - 'SHLVL': '1', 23:23:14 INFO - 'TERM': 'linux', 23:23:14 INFO - 'TMOUT': '86400', 23:23:14 INFO - 'USER': 'cltbld', 23:23:14 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:14 INFO - '_': '/tools/buildbot/bin/python'} 23:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:14 INFO - Downloading/unpacking flake8 23:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:23:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:23:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:23:17 INFO - no previously-included directories found matching 'docs/_build' 23:23:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:23:17 INFO - Running setup.py install for pep8 23:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:23:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:23:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:23:17 INFO - no previously-included directories found matching 'docs/_build' 23:23:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:23:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:23:17 INFO - Cleaning up... 23:23:17 INFO - Return code: 0 23:23:17 INFO - Running post-action listener: _resource_record_post_action 23:23:17 INFO - Running post-action listener: _start_resource_monitoring 23:23:17 INFO - Starting resource monitoring. 23:23:17 INFO - ##### 23:23:17 INFO - ##### Finished create-virtualenv step (success) 23:23:17 INFO - ##### 23:23:17 INFO - ##### 23:23:17 INFO - ##### Running install step. 23:23:17 INFO - ##### 23:23:17 INFO - Running pre-action listener: _resource_record_pre_action 23:23:17 INFO - Running main action method: install 23:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:17 INFO - Reading from file tmpfile_stdout 23:23:17 INFO - Detecting whether we're running mozinstall >=1.0... 23:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:23:17 INFO - Reading from file tmpfile_stdout 23:23:17 INFO - Output received: 23:23:17 INFO - Usage: mozinstall [options] installer 23:23:17 INFO - Options: 23:23:17 INFO - -h, --help show this help message and exit 23:23:17 INFO - -d DEST, --destination=DEST 23:23:17 INFO - Directory to install application into. [default: 23:23:17 INFO - "/builds/slave/test"] 23:23:17 INFO - --app=APP Application being installed. [default: firefox] 23:23:17 INFO - mkdir: /builds/slave/test/build/application 23:23:17 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'] 23:23:17 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 23:23:33 INFO - Reading from file tmpfile_stdout 23:23:33 INFO - Output received: 23:23:33 INFO - /builds/slave/test/build/application/firefox/firefox 23:23:33 INFO - Running post-action listener: _resource_record_post_action 23:23:33 INFO - ##### 23:23:33 INFO - ##### Finished install step (success) 23:23:33 INFO - ##### 23:23:33 INFO - ##### 23:23:33 INFO - ##### Running run-tests step. 23:23:33 INFO - ##### 23:23:33 INFO - Running pre-action listener: _resource_record_pre_action 23:23:33 INFO - Running main action method: run_tests 23:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:23:33 INFO - Python 2.7.3 23:23:33 INFO - Return code: 0 23:23:33 INFO - grabbing minidump binary from tooltool 23:23: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')]} 23:23:33 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 0x14f22c0>, '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 0x14f31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f3650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:23:33 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 23:23:33 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 23:23:33 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 23:23:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:23:33 INFO - Return code: 0 23:23:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:23:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:23:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:23:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:23:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:23:34 INFO - Return code: 0 23:23:34 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:23:34 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:23:34 INFO - Using env: {'DISPLAY': ':0', 23:23:34 INFO - 'HOME': '/home/cltbld', 23:23:34 INFO - 'LANG': 'en_US.UTF-8', 23:23:34 INFO - 'LANGUAGE': 'en_US:en', 23:23:34 INFO - 'LOGNAME': 'cltbld', 23:23:34 INFO - 'MAIL': '/var/mail/cltbld', 23:23:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:23:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:34 INFO - 'MOZ_NO_REMOTE': '1', 23:23:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:34 INFO - 'NO_EM_RESTART': '1', 23:23:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:34 INFO - 'PWD': '/builds/slave/test', 23:23:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:23:34 INFO - 'SHELL': '/bin/bash', 23:23:34 INFO - 'SHLVL': '1', 23:23:34 INFO - 'TERM': 'linux', 23:23:34 INFO - 'TMOUT': '86400', 23:23:34 INFO - 'USER': 'cltbld', 23:23:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085', 23:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:34 INFO - '_': '/tools/buildbot/bin/python'} 23:23:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:23:34 INFO - mozversion application_buildid: 20160713152443 23:23:34 INFO - mozversion application_changeset: 709652b674013b136627e45fd90b4e9063906a19 23:23:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:23:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:23:34 INFO - mozversion application_name: Firefox 23:23:34 INFO - mozversion application_remotingname: firefox-dev 23:23:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:23:34 INFO - mozversion application_vendor: Mozilla 23:23:34 INFO - mozversion application_version: 49.0a2 23:23:34 INFO - mozversion platform_buildid: 20160713152443 23:23:34 INFO - mozversion platform_changeset: 709652b674013b136627e45fd90b4e9063906a19 23:23:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:23:34 INFO - mozversion platform_version: 49.0a2 23:23:34 INFO - using testdate: 1468477414 23:23:34 INFO - actual date: 1468477414 23:23:34 INFO - starting webserver on 'localhost:59563' 23:23:34 INFO - SUITE-START | Running 2 tests 23:23:34 INFO - TEST-START | dromaeo_css 23:23:34 INFO - operating with platform_type : linux_ 23:23:34 INFO - Initialising browser for dromaeo_css test... 23:23:34 INFO - TEST-INFO | started process 28787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpik6Bm2/profile http://localhost:59563/getInfo.html) 23:23:39 INFO - PROCESS | 28787 | __metrics Screen width/height:1600/1200 23:23:39 INFO - PROCESS | 28787 | colorDepth:24 23:23:39 INFO - PROCESS | 28787 | Browser inner width/height: 1024/697 23:23:39 INFO - PROCESS | 28787 | __metrics 23:23:40 ERROR - PROCESS | 28787 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:23:40 INFO - TEST-INFO | 28787: exit 0 23:23:40 INFO - Browser initialized. 23:23:40 INFO - Running cycle 1/1 for dromaeo_css test... 23:23:40 INFO - TEST-INFO | started process 28917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpik6Bm2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:23:52 INFO - PROCESS | 28917 | RSS: Main: 156344320 23:23:52 INFO - PROCESS | 28917 | 23:24:42 INFO - PROCESS | 28917 | 1468477482396 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] 23:26:50 INFO - PROCESS | 28917 | Cycle 1(1): loaded http://localhost:59563/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59563/tests/dromaeo/cssquery-ext.html) 23:26:51 INFO - PROCESS | 28917 | RSS: Main: 159584256 23:26:51 INFO - PROCESS | 28917 | 23:29:53 INFO - PROCESS | 28917 | Cycle 1(1): loaded http://localhost:59563/tests/dromaeo/cssquery-ext.html (next: http://localhost:59563/tests/dromaeo/cssquery-jquery.html) 23:29:54 INFO - PROCESS | 28917 | RSS: Main: 157245440 23:29:54 INFO - PROCESS | 28917 | 23:32:55 INFO - PROCESS | 28917 | Cycle 1(1): loaded http://localhost:59563/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59563/tests/dromaeo/cssquery-mootools.html) 23:32:56 INFO - PROCESS | 28917 | RSS: Main: 157212672 23:32:56 INFO - PROCESS | 28917 | 23:35:58 INFO - PROCESS | 28917 | Cycle 1(1): loaded http://localhost:59563/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59563/tests/dromaeo/cssquery-prototype.html) 23:35:58 INFO - PROCESS | 28917 | RSS: Main: 156753920 23:35:58 INFO - PROCESS | 28917 | 23:39:01 INFO - PROCESS | 28917 | Cycle 1(1): loaded http://localhost:59563/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59563/tests/dromaeo/cssquery-yui.html) 23:39:01 INFO - PROCESS | 28917 | RSS: Main: 158695424 23:39:01 INFO - PROCESS | 28917 | 23:42:04 INFO - PROCESS | 28917 | Cycle 1(1): loaded http://localhost:59563/tests/dromaeo/cssquery-yui.html (next: http://localhost:59563/tests/dromaeo/cssquery-dojo.html) 23:42:04 INFO - PROCESS | 28917 | RSS: Main: 159338496 23:42:04 INFO - PROCESS | 28917 | 23:42:04 INFO - PROCESS | 28917 | __start_tp_report 23:42:04 INFO - PROCESS | 28917 | _x_x_mozilla_page_load 23:42:04 INFO - PROCESS | 28917 | _x_x_mozilla_page_load_details 23:42:04 INFO - PROCESS | 28917 | |i|pagename|runs| 23:42:04 INFO - PROCESS | 28917 | |0;dojo.html;3275.9680700579315;3312.470004799233;3338.0152854907806;3356.1945133168047;3362.3275344931003;5546.4453554644515;5559.833205003852;5570;5574.219609254707;5591.049521581331;5578.191162281467;5607.57943154264;5630.324361076667;5650.29371328584;5656.547476201904;5084.034033533635;5152.793888244466;5164.535191832734;5172.09488339541;5203.19350500673;5088.7964481420695;5101.15830887903;5221.686698798066;5229.921551176735;5261.316028916235;5087.643864929457;5111.08000559899;5148.665336753118;5153.69077855328;5208.973955130219;5158.48415158483;5172.482751724835;5188;5228.581713462914;5266.973665131688;4986.700797952134;5086.949130508721;5160.071187186305;5200.713960732158;5218.321618189611;5425.077736784717;5430.185472179165;5461.481159289861;5510.834674959758;5534.4742249486235;5943.3165186003735;5981.461668449861;5991.131285963511;5997.22036135304;6000.669963152025;5871.031279838864;5938.435848594377;6030.09548567714;6030.427109424598;6044.395560443964;5598.300212473441;5689.857753556194;5692.57305702074;5707.6290041147195;5728.51307638847;6136.110264011693;6154.3845615438095;6163.630182189083;6167.136600875881;6171.444569988723;5767.22142510764;5844.444777746107;5859.355470898197;5924.844655292263;5932.822015339547;6017.097435384728;6019;6021.969890150609;6037.698115094316;6051.152838602599;5952.285725712942;5965.671888046112;5986.46121849027;6001.159837622737;6017.097435384728;5752.539796816244;5885.61743486672;5905.409459054146;5923.318818335946;6005.909911351333;4572.611328037087;4587.3807036050375;4604;4604.631629469634;4612.192866248393;4093.692973027035;4105.035316700573;4107.342825147962;4123.546409894909;4144.026153853842;5658.943410565924;5745.798897038583;5782.2483077199695;5813;5861.501772349398;5925;5973.223480947536;6001.12983617373;6005.588686658632;6053;5652.519535839418;5777.711114444261;5788.594798364158;5792.333881603585;5801.158831969341;5066.341375621219;5107.310513080761;5117.437081920985;5136.0241554104605;5140.203268493389;6173.382661733791;6183.381661833871;6241.469475094668;6266.843328916722;6282.560220784501;5885.14665373527;5998.970005149947;6046.244219472566;6048.485878700271;6050.45545900871;6177.96911015442;6234.75060997555;6256.374362563707;6283.905741413791;6326.620402775849;5833.358330583547;5956.851078722893;5964.045752679551;5972.800111753075;6001;5871.354151043296;5935.643861368331;5937.435943585352;6048.637081775108;6081.027035674271;5856.824295271149;5886.646801191942;5888.205092312654;5890;5898.203742494708;5854.180414741854;5867.471927526543;5897.941020589739;5901.940980590311;5909.70451477433;5578.693171875586;5768.134779783066;5777.306723193244;5801.36185019639;5825;5922.378150294157;5924.289085309618;5956.166136740773;5967.671778052249;5984.910226346696;5839.065749480063;5845.064789633639;5846.239988801429;5856.267966504187;5860.912086318794 23:42:04 INFO - PROCESS | 28917 | |1;ext.html;602.331412132533;647.3300134360937;661.9040239165319;667.5527396644247;681.6421378776145;40730;45627.08745825082;46150.53849461509;46181.53818461814;46658.53341466584;45882.541174588245;47400.52599474004;47431.76284118583;47504;47795;8968.192862642361;9014.954925225366;9077.863832042525;9089.363744537884;9094.045125261851;8983.910160898373;9049.095090490931;9082.636694532212;9089.95465521467;9096.909030909672;9109;9138.223251023672;9140.497272650035;9179;9184.724458266262;9005.459672419644;9073.36486445949;9077.45535267886;9115.81768364629;9136.132067453647;8930.955345223298;8993.325500587416;9006.189442950166;9055.637774489078;9058.139476749764;42759.35860962088;42807.35788963168;42808.3578746319;42965.57034429678;43196;3728.5898551159353;3742.2141350316465;3787.6780473659774;3821.216650586623;4084.7140700151003;34105.829470852485;34732.30535389303;34863.4770478443;34920.65079349225;34937;4355;4408.713433626804;4413.0732546165345;4450.866474005785;4480.8879778005485;354917;354982;356522.21738891397;356602;357217;61726;61839.38160618426;62341.376586234466;62381.37618623846;62570;39066.218675626325;40075.59924400777;40114.799426003265;42387.364189537184;42499.57500425018;16348.836511634732;16412.589685257724;16452.259648315616;16546.66906661884;16578.75131873023;12205.633830985085;12333.75332493363;12353.876461235273;12375.75248495043;12384.690382740504;20925.26761563338;20937.05783239758;21134.88651134905;21365.893170534047;21369.358919232447;7579.2420757924865;7876.17300183484;7887.723929662434;8017.839643207103;8018.799530011796;997.0826839307854;1061.3737894642197;1075.2580719303655;1095.9890401096047;1132.824412216108;32499.675003250137;32539.34921301608;32669.346613067606;33151.3369732604;33192;1120.120705246394;1159.0437888741653;1168.1472525056756;1175.1832476428972;1178.4049055227056;17343.826561734473;17412.651746964988;17478.563035923948;17573.472795816146;17678;159380.20309898377;562267;572473;636408;641071;59993.70003149956;60623.69688151531;60777.08834367488;60974.695126524086;60998.39001609927;1460.5399299220712;1479.578320178744;1493.6041948883556;1497.5357639131687;1506.3296832909468;31320.843395782875;31412.214694631904;31556.36887262288;31817.840910795298;32511.51232731558;50371.49628503815;50649;50660.74669626628;50796.74601626968;50987;411040;416172;419551;419964;420844;29518;29627.703722963357;29834;29969.70030299669;29983.70016299809;47286.52713472821;47993;48081.278780817614;48762.26856597083;48862.26706599333;39587.406188906614;40329;40436.393454097626;40518;41309.38035929524;39016.80491597524;39828.60171398249;40088.1982360357;40115;40914;39640.80179599083;40416.19167616573;40737;40759.79620101999;41087.589124109574;34122.658773411946;35043.12392190113;35613.465798012534;36640;38404;29595.85202073976;30139.246518836328;30193.547096794005;30551;30718.84640576783 23:42:04 INFO - PROCESS | 28917 | |2;jquery.html;425.1709167124109;427.32696003793995;427.3738972405426;428.30828212436916;448.17312059250673;18801.71797423038;20033.899830500864;20706.482337941557;21319.36041918741;21332.57334853302;17364.913175434103;17631.64736705265;17972.460826175236;18142.546436339064;18144.45566633;5616.297962754656;5991.820245392623;6000.939990600082;6022.096685497188;6028.4574388305045;5498.340199176105;5783.103618939072;5879.941200587982;5907.852303692421;5953.3451320354725;5776.451237132465;5822.359540450547;5848.210491583645;5862.765489380419;5901.822945311647;5704.515116215127;6009.06859436788;6009.308929473101;6011.969940150315;6013.51891848651;5679.062954612484;5808.448197421239;5828.125781132821;5843.415658434165;5852.414758524156;14909.105453672815;15009.924950375178;15108;22009.779902200935;24795.87602061978;2329.429289823987;2342.519783444407;2462.827602067856;2504.8747562621797;2584.4185058361904;10904.50929708165;11048.392338421383;11104.888951110466;11263.66209013731;11282.097432205404;1955.7946415626297;2077.418322869599;2125.5855108253895;2165.1880544795704;2179.1129389181974;77667.61166194132;82132;84765;86484.13515864823;88761;11611;11808.642006169228;12075.154739168174;12182;12188.390580470941;17101.828981710274;17270.050147242022;17337.913310433367;17362.91318543399;17434.12829358527;8121.593920303962;8254.628541715638;8296.419250652518;8437.915620843836;8566.443181193203;7556.282153195438;7759.72840950564;7872.803179920434;7951.204879512003;7987.480813747088;4903.092927808367;5047.848564543069;5094.465081166498;5214.374275086938;5345;2050.7797860273113;2114.492521794758;2134.711813905103;2138.550904310081;2159.66525188596;995.8356871116184;1042.6142327338932;1115.297362661518;1124.2579897267765;1132.9830052549219;19952;20186.09162587687;20365.592688146153;20400;20439.386818395473;1085.5708708469426;1087.9782404351868;1102.443266150589;1110.677903408019;1123.5898896902736;11314.264572802742;11325;11449.54201831934;11526.711832204262;11587.14023758269;488292;494764;495050;505940;506960;91503.54248228716;93234;96755.51622241843;101057;101500;495.34366963772425;511.15659162382366;518.4659800405589;519.7713006277302;520.0093821270561;11448.427578621202;11815.881841181477;12167.574134905235;12248.448819803309;12546.811797822857;43048;43058.354124687525;44528.33207501955;44755.552444475135;45513.54486455093;60941.69529152503;61230.693846530485;61686;63703.6814815923;63710;9312.48781317034;9335.719928402159;9379.484128373006;9667;9682.70951871445;10244.59021639156;13882.16706997543;13928.442862285396;13958.09272397291;14113.2943352834;11993.34036627959;12529.624111276677;12672.809907851206;12808.295543745184;12857;12025.579104731292;12305.815412768994;12308.876911230773;12359.62921112368;12631.557895473614;12617.684557886127;12641;12716.109872308849;12763.361831908182;12844.550440734904;9466.479343636167;9469.14777670013;9489.76275593088;9590.42457452555;9596.328257021942;9894.455804930798;12685.302308373128;12772.233665980071;12871.678208044874;12875.935620321838 23:42:04 INFO - PROCESS | 28917 | |3;mootools.html;1562.2188905547227;1588.4361051826602;1791.2208189437595;1875.4373687893628;1895.5829717462154;9163.541822908854;9561.569729362178;9800.85298720519;9821.165200957917;9828.655997040105;9816.852747208797;9984.700458986243;9986.550605222765;10022.899771002289;10106.09045185933;2500.974990250097;2534.619807028951;2543.656606358146;2544.185860524633;2549.5028469448466;2507.335556077641;2572.0740533407957;2581.1998280533094;2586.4180559374176;2588.637590737298;2381.499885024138;2407.9518409631796;2468.7778099971;2478.330850670318;2481.727010028895;2438.0735320578156;2443.315871555967;2470.1231062972656;2476.925692229236;2483.5653760592004;2430.501747141832;2451.681281433402;2467.481828815951;2472.11004038546;2486;9725.027497250288;9835.557399917021;9849.852252216222;9850.50747462631;9850.655227067018;5492.917606235909;5571.721413929328;5584.944150558483;5599.608027438081;5625.5218306444;3693.815309234554;3764.9058773530605;3843.0584506796013;3859.710521710883;3872.7289089763726;1225.5771758743308;1231.3904617214537;1241.9068569857207;1280.5262053040342;1302.2446980751142;12576.68558286041;12866.356682165855;12873.742525149539;12910.22538647684;12961.351932403342;4965.32968049316;5106.744662766847;5108.514691104339;5112.693238405707;5163.845084647466;11285.492152853141;11382.317060976367;11418.42907854604;11446.599369022044;11447.656570302905;5524.392316845144;5546.27898373217;5556.499915007668;5609.298837645294;5612.550995920316;4364.912701745948;4867.3915760529935;5025.070361983045;5028.748562571856;5034.06869729094;4256;4302.376155457441;4338.566143385636;4353.69524133314;4384.539623339503;1345.710672205461;1377.442135934948;1384.7922811578142;1386.1475192756584;1395.9371828267751;1048.1719441641171;1076.1874784537624;1094.8248280275277;1104.1553211792984;1131.7510147767478;6304.716287767062;6506.4469520091325;6514.3811337922825;6622.569532980341;6668.266490686021;462.854200926707;471.4719514144181;478.394830539368;489.52516059422305;490.872373182975;4537.274036154199;4584.770761461914;4608.907821843544;4609.792559334838;4621.376114224537;11185.832212516818;11463.598774042868;11463.656090317303;11463.885361146282;11472.713182170513;11283;11361.204715669825;11397.658070257905;11774.764504709858;11793.823092653616;8882.378233523721;9058.365914386062;9073.500957447404;9091.863622045674;9100.544972751335;6668.566543174678;6732.5907778980245;6764.49266305039;6891.586504809728;7009;11113.166512511432;11143.665690029313;11165.609203677832;11176;11472;11194.328340299608;11542.480588373375;11621.5351385947;11669.649910502698;11704;7792.454528182972;8223.136570659995;8492.193241642035;8632.827343453222;8770.649174033222;9557.522123893916;9593.42439453635;9608.183304419203;9628;9672.516374181403;8451.66193352259;8583.442076265022;8624.52565108925;8648.135186481302;8683.305335573014;8283.50298982063;8313.792155196168;8461.576921154041;8462.407631465738;8510.574471276535;7877.448578599443;7932.444728868923;7998.000249968754;8006.919930800617;8013.2387423194705;5650.802221922213;5709.400512946247;5806.4483874033585;5841.1238314253205;5852.970735146297;5700.486956173964;5705.058665320175;5718.1136923776885;5730.451757384874;5783.045797443375 23:42:04 INFO - PROCESS | 28917 | |4;prototype.html;351.467526697054;353.04853420033015;358.64315006568467;359.10045336432233;359.63497050493754;5750.424957504248;5759.856003599902;5783.479486846183;5799.072148456248;5806.796762113321;5633.352164501083;5635.6055076144685;5638.182463542794;5640.238567793357;5654.886902261952;4277.272863613185;4378.102488989765;4388.86833394997;4393.626541743955;4431.401760762305;4366.694331396803;4416.492103408117;4426.269665505188;4429.490608580022;4442.222611043071;4367.934480982788;4387.7367357958465;4388.341748737699;4394.07724377881;4397.230484665187;4281.871543853674;4363.498197707273;4368.672349573794;4374.278244089722;4410.338449232609;3803.3154032274456;3803.581606023363;3821.9617803821884;3825.7513261637905;3831.04223944014;5508.4491550845;5513.862153446155;5521.4478552144865;5533.22534845122;5587.469190426903;4902.730349830794;5004.172642457036;5022.874428139289;5025.497450254982;5052.974735126338;5849.883002339972;5861.85345366365;5924.940750592482;5932.644041357532;5941;4312.892177695551;4322.6325762309925;4324.286492728696;4333.848315308949;4338.783060846945;6089.751600921801;6102.755889764404;6120.877582448371;6197.287311959138;6202.720877560476;4248.532661407243;4267.231898258343;4275.166342563232;4279.507856596469;4293.720908140961;4339.63113135387;4355.390245365651;4361.411209486679;4361.890952726208;4377.321515165155;4866.562009419169;4988.12707776145;5010.423801262901;5025.246213067996;5042.520960508746;5948.434898684618;5954.702264886739;5990.221271234712;5995.46040856325;6015.187949626745;1507.366905899525;1512.6672132130914;1515.6514001779653;1520.1335238913714;1520.711064897688;951.1914872358578;973.561897146287;980.6567701304486;983.5573991703762;995.6515219673056;5199.428062913076;5222.947770522323;5239.973800130975;5255.658382205144;5309.920351194735;5445.264889239981;5505.4584716279505;5507.7246137692955;5513.917291240635;5561.443855614487;4930.605551555867;5192.9740351298005;5222.556082732935;5222.895542089137;5248.343957005374;2905.17202597263;2924.1081470151385;2930.7508861746564;2955.138262894363;2958.6301712285963;5705.2012718219485;5705.857353566194;5759.798407055733;5779;5803.419658034163;5181.637285389987;5464;5579.246801681721;5586.469285417878;5598.216249725042;5539.845116162878;5729.512991395778;5752.539796816244;5760.337561180434;5776.8048141705885;5127.051495473349;5457.263269458731;5475;5509.162781167622;5588.714595642944;5391.7304134793885;5469.398366179637;5486.61593688438;5521.3926468087675;5826.359100498857;6302.550413405034;6318.652474113968;6454.548181627241;6466.256380516113;6488.643124628191;4327.264365057885;4386.990992071906;4391.956080439155;4393.582609652206;4406.691531592758;5921.3190483094995;6192.349803270772;6222.253329600477;6263.843403914939;6291.402316779899;5997.760089596367;6044.24446944132;6091.928744226984;6096.22621707131;6101.176341194059;5800.984827655059;6053.878922421615;6069.726862291119;6070.453659170696;6089.9342615041305;5933.418962751217;5950.494207992369;5978.3722709116655;5985.25184351956;5986.2217911671205;6060.727267272895;6070.48400885912;6070.876887775776;6073.937061014393;6096.29892562361;5651.400355836361;5947.434993675594;5948.970255148696;5963.522918166623;5979.970100149471 23:42:04 INFO - PROCESS | 28917 | |5;yui.html;797.7806103321586;817.7464985854382;863.8709741334048;869.4218344800706;910.9863352049719;15656.3737450502;15697.215139243035;15859.207039648;15889.602759931007;15899.68200635988;14253.429862805502;14302.427902883872;14309;14402.567922962302;14429.783553246709;835.6740871060276;837.539353355652;841.4824882697128;844.2992316377392;848.6690190825583;836.431226765799;843.0178841649501;843.4475418600827;843.9198276163754;844.6832437835811;888.4802390601506;892.8437523433406;893.1648908270788;895.2390468102126;898.9550522473883;878.97802554936;882.6160620130232;886.02979737188;887.0685779931047;889.7197382824389;646.214848958513;651.1112331667288;651.8240075179723;652.6280020388381;655.9672016399209;14703.33834977418;14718.116912985148;14756.631084222872;14787;14845.257737113101;13367.131136476195;13486.527971520949;13501.2574308413;13526.120802147927;13562.186268823902;12032.27806331623;12263.877361226363;12274.447649855689;12333;12349.567765128268;4005.919881602352;4041.8585349512628;4082.9591704082877;4149.087200815816;4208.431861698693;55349;65954.67022664905;66707.3329266706;68787.65606171938;77152.61423692845;12904.096713230172;13036.54372096991;13064.804027939588;13070.803937940938;13246.668833279246;24379.26862194137;24429.38926526851;24467.38831529226;24481.877590611934;24510.632340514905;8881.777955551033;8920.107989201028;8928.464292142493;9039.593218305192;9168.679096231734;4963.404391473046;5072.82245121419;5097.8215762448135;5115.897682046339;5193.948060519422;3935.193285376491;3988.2621714982242;4014.7791871447353;4027.3354896442347;4042.4744783178;726.179417258505;739.1352118021928;742.157651066044;747.3460721868365;762.3520007993161;627.8901192291331;702.9859402811915;746.8655641984386;768.9465432357593;780.4068907630128;10905.83641245382;10996.890031099747;11177.273477223955;11370.886291137149;11580.826287605692;760.8174038230785;769.8037000564821;772.4052479590683;783.7844592736928;789.2659826361424;5070.2141168119;5151.871203219949;5195.922061169085;5207.3230480037355;5224.9738751306;76875.61562192153;77217;77224.2277577217;89255;90569.54715226381;108576;108964;111356;112871;113148;65958.67020664866;73645;74929;84021.57989210016;87761;10487.632932847313;10559.155267578422;10668.519916603616;10795.190360723134;10965.83551246716;54601.1809822845;55046.72476637591;55124.448755513535;55329.44670553404;55626;72719.63640181765;75626.62186689032;76964;77358.6132069336;77432;13460.663483412993;13883;14003.159810411407;14062.718745625234;14094.788578171541;15796.60508487297;15954.920225398799;16057.437989670305;16752.58118546997;16993.66012679715;13883.236421996888;14570.271486425425;14669.70660586761;15287.388504459697;15363.23183840826;14001.929990349983;14198.503052393116;14352.56942291733;14446;14635.634109147357;14256.42974281017;14589.708205836036;14607.19660418687;14875.628109297355;15009.849901501282;11684;11871.228370155912;11944.581939632071;12036.157468977088;12272.509099635914;12310.569130080405;12501.187422817487;12686.111972162229;12838.191004803892;13081.542146024844 23:42:04 INFO - PROCESS | 28917 | __end_tp_report 23:42:04 INFO - PROCESS | 28917 | __start_cc_report 23:42:04 INFO - PROCESS | 28917 | _x_x_mozilla_cycle_collect,339 23:42:04 INFO - PROCESS | 28917 | __end_cc_report 23:42:04 INFO - PROCESS | 28917 | __startTimestamp1468478524416__endTimestamp 23:42:04 INFO - PROCESS | 28917 | 23:42:04 INFO - PROCESS | 28917 | ------- Summary: start ------- 23:42:04 INFO - PROCESS | 28917 | Number of tests: 6 23:42:04 INFO - PROCESS | 28917 | 23:42:04 INFO - PROCESS | 28917 | [#0] dojo.html Cycles:165 Average:5590.02 Median:5839.07 stddev:619.64 (10.6%) stddev-sans-first:594.36 23:42:04 INFO - PROCESS | 28917 | Values: 3276.0 3312.5 3338.0 3356.2 3362.3 5546.4 5559.8 5570.0 5574.2 5591.0 5578.2 5607.6 5630.3 5650.3 5656.5 5084.0 5152.8 5164.5 5172.1 5203.2 5088.8 5101.2 5221.7 5229.9 5261.3 5087.6 5111.1 5148.7 5153.7 5209.0 5158.5 5172.5 5188.0 5228.6 5267.0 4986.7 5086.9 5160.1 5200.7 5218.3 5425.1 5430.2 5461.5 5510.8 5534.5 5943.3 5981.5 5991.1 5997.2 6000.7 5871.0 5938.4 6030.1 6030.4 6044.4 5598.3 5689.9 5692.6 5707.6 5728.5 6136.1 6154.4 6163.6 6167.1 6171.4 5767.2 5844.4 5859.4 5924.8 5932.8 6017.1 6019.0 6022.0 6037.7 6051.2 5952.3 5965.7 5986.5 6001.2 6017.1 5752.5 5885.6 5905.4 5923.3 6005.9 4572.6 4587.4 4604.0 4604.6 4612.2 4093.7 4105.0 4107.3 4123.5 4144.0 5658.9 5745.8 5782.2 5813.0 5861.5 5925.0 5973.2 6001.1 6005.6 6053.0 5652.5 5777.7 5788.6 5792.3 5801.2 5066.3 5107.3 5117.4 5136.0 5140.2 6173.4 6183.4 6241.5 6266.8 6282.6 5885.1 5999.0 6046.2 6048.5 6050.5 6178.0 6234.8 6256.4 6283.9 6326.6 5833.4 5956.9 5964.0 5972.8 6001.0 5871.4 5935.6 5937.4 6048.6 6081.0 5856.8 5886.6 5888.2 5890.0 5898.2 5854.2 5867.5 5897.9 5901.9 5909.7 5578.7 5768.1 5777.3 5801.4 5825.0 5922.4 5924.3 5956.2 5967.7 5984.9 5839.1 5845.1 5846.2 5856.3 5860.9 23:42:04 INFO - PROCESS | 28917 | 23:42:04 INFO - PROCESS | 28917 | [#1] ext.html Cycles:180 Average:59308.74 Median:22499.36 stddev:118732.89 (527.7%) stddev-sans-first:118984.15 23:42:04 INFO - PROCESS | 28917 | Values: 602.3 647.3 661.9 667.6 681.6 40730.0 45627.1 46150.5 46181.5 46658.5 45882.5 47400.5 47431.8 47504.0 47795.0 8968.2 9015.0 9077.9 9089.4 9094.0 8983.9 9049.1 9082.6 9090.0 9096.9 9109.0 9138.2 9140.5 9179.0 9184.7 9005.5 9073.4 9077.5 9115.8 9136.1 8931.0 8993.3 9006.2 9055.6 9058.1 42759.4 42807.4 42808.4 42965.6 43196.0 3728.6 3742.2 3787.7 3821.2 4084.7 34105.8 34732.3 34863.5 34920.7 34937.0 4355.0 4408.7 4413.1 4450.9 4480.9 354917.0 354982.0 356522.2 356602.0 357217.0 61726.0 61839.4 62341.4 62381.4 62570.0 39066.2 40075.6 40114.8 42387.4 42499.6 16348.8 16412.6 16452.3 16546.7 16578.8 12205.6 12333.8 12353.9 12375.8 12384.7 20925.3 20937.1 21134.9 21365.9 21369.4 7579.2 7876.2 7887.7 8017.8 8018.8 997.1 1061.4 1075.3 1096.0 1132.8 32499.7 32539.3 32669.3 33151.3 33192.0 1120.1 1159.0 1168.1 1175.2 1178.4 17343.8 17412.7 17478.6 17573.5 17678.0 159380.2 562267.0 572473.0 636408.0 641071.0 59993.7 60623.7 60777.1 60974.7 60998.4 1460.5 1479.6 1493.6 1497.5 1506.3 31320.8 31412.2 31556.4 31817.8 32511.5 50371.5 50649.0 50660.7 50796.7 50987.0 411040.0 416172.0 419551.0 419964.0 420844.0 29518.0 29627.7 29834.0 29969.7 29983.7 47286.5 47993.0 48081.3 48762.3 48862.3 39587.4 40329.0 40436.4 40518.0 41309.4 39016.8 39828.6 40088.2 40115.0 40914.0 39640.8 40416.2 40737.0 40759.8 41087.6 34122.7 35043.1 35613.5 36640.0 38404.0 29595.9 30139.2 30193.5 30551.0 30718.8 23:42:04 INFO - PROCESS | 28917 | 23:42:04 INFO - PROCESS | 28917 | [#2] jquery.html Cycles:180 Average:29685.52 Median:2402.67 stddev:82300.53 (3425.4%) stddev-sans-first:82502.08 23:42:04 INFO - PROCESS | 28917 | Values: 425.2 427.3 427.4 428.3 448.2 18801.7 20033.9 20706.5 21319.4 21332.6 17364.9 17631.6 17972.5 18142.5 18144.5 5616.3 5991.8 6000.9 6022.1 6028.5 5498.3 5783.1 5879.9 5907.9 5953.3 5776.5 5822.4 5848.2 5862.8 5901.8 5704.5 6009.1 6009.3 6012.0 6013.5 5679.1 5808.4 5828.1 5843.4 5852.4 14909.1 15009.9 15108.0 22009.8 24795.9 2329.4 2342.5 2462.8 2504.9 2584.4 10904.5 11048.4 11104.9 11263.7 11282.1 1955.8 2077.4 2125.6 2165.2 2179.1 77667.6 82132.0 84765.0 86484.1 88761.0 11611.0 11808.6 12075.2 12182.0 12188.4 17101.8 17270.1 17337.9 17362.9 17434.1 8121.6 8254.6 8296.4 8437.9 8566.4 7556.3 7759.7 7872.8 7951.2 7987.5 4903.1 5047.8 5094.5 5214.4 5345.0 2050.8 2114.5 2134.7 2138.6 2159.7 995.8 1042.6 1115.3 1124.3 1133.0 19952.0 20186.1 20365.6 20400.0 20439.4 1085.6 1088.0 1102.4 1110.7 1123.6 11314.3 11325.0 11449.5 11526.7 11587.1 488292.0 494764.0 495050.0 505940.0 506960.0 91503.5 93234.0 96755.5 101057.0 101500.0 495.3 511.2 518.5 519.8 520.0 11448.4 11815.9 12167.6 12248.4 12546.8 43048.0 43058.4 44528.3 44755.6 45513.5 60941.7 61230.7 61686.0 63703.7 63710.0 9312.5 9335.7 9379.5 9667.0 9682.7 10244.6 13882.2 13928.4 13958.1 14113.3 11993.3 12529.6 12672.8 12808.3 12857.0 12025.6 12305.8 12308.9 12359.6 12631.6 12617.7 12641.0 12716.1 12763.4 12844.6 9466.5 9469.1 9489.8 9590.4 9596.3 9894.5 12685.3 12772.2 12871.7 12875.9 23:42:04 INFO - PROCESS | 28917 | 23:42:04 INFO - PROCESS | 28917 | [#3] mootools.html Cycles:180 Average:6345.87 Median:4609.35 stddev:3619.57 (78.5%) stddev-sans-first:3611.87 23:42:04 INFO - PROCESS | 28917 | Values: 1562.2 1588.4 1791.2 1875.4 1895.6 9163.5 9561.6 9800.9 9821.2 9828.7 9816.9 9984.7 9986.6 10022.9 10106.1 2501.0 2534.6 2543.7 2544.2 2549.5 2507.3 2572.1 2581.2 2586.4 2588.6 2381.5 2408.0 2468.8 2478.3 2481.7 2438.1 2443.3 2470.1 2476.9 2483.6 2430.5 2451.7 2467.5 2472.1 2486.0 9725.0 9835.6 9849.9 9850.5 9850.7 5492.9 5571.7 5584.9 5599.6 5625.5 3693.8 3764.9 3843.1 3859.7 3872.7 1225.6 1231.4 1241.9 1280.5 1302.2 12576.7 12866.4 12873.7 12910.2 12961.4 4965.3 5106.7 5108.5 5112.7 5163.8 11285.5 11382.3 11418.4 11446.6 11447.7 5524.4 5546.3 5556.5 5609.3 5612.6 4364.9 4867.4 5025.1 5028.7 5034.1 4256.0 4302.4 4338.6 4353.7 4384.5 1345.7 1377.4 1384.8 1386.1 1395.9 1048.2 1076.2 1094.8 1104.2 1131.8 6304.7 6506.4 6514.4 6622.6 6668.3 462.9 471.5 478.4 489.5 490.9 4537.3 4584.8 4608.9 4609.8 4621.4 11185.8 11463.6 11463.7 11463.9 11472.7 11283.0 11361.2 11397.7 11774.8 11793.8 8882.4 9058.4 9073.5 9091.9 9100.5 6668.6 6732.6 6764.5 6891.6 7009.0 11113.2 11143.7 11165.6 11176.0 11472.0 11194.3 11542.5 11621.5 11669.6 11704.0 7792.5 8223.1 8492.2 8632.8 8770.6 9557.5 9593.4 9608.2 9628.0 9672.5 8451.7 8583.4 8624.5 8648.1 8683.3 8283.5 8313.8 8461.6 8462.4 8510.6 7877.4 7932.4 7998.0 8006.9 8013.2 5650.8 5709.4 5806.4 5841.1 5853.0 5700.5 5705.1 5718.1 5730.5 5783.0 23:42:04 INFO - PROCESS | 28917 | 23:42:04 INFO - PROCESS | 28917 | [#4] prototype.html Cycles:180 Average:4885.61 Median:5508.09 stddev:1432.76 (26.0%) stddev-sans-first:1395.77 23:42:04 INFO - PROCESS | 28917 | Values: 351.5 353.0 358.6 359.1 359.6 5750.4 5759.9 5783.5 5799.1 5806.8 5633.4 5635.6 5638.2 5640.2 5654.9 4277.3 4378.1 4388.9 4393.6 4431.4 4366.7 4416.5 4426.3 4429.5 4442.2 4367.9 4387.7 4388.3 4394.1 4397.2 4281.9 4363.5 4368.7 4374.3 4410.3 3803.3 3803.6 3822.0 3825.8 3831.0 5508.4 5513.9 5521.4 5533.2 5587.5 4902.7 5004.2 5022.9 5025.5 5053.0 5849.9 5861.9 5924.9 5932.6 5941.0 4312.9 4322.6 4324.3 4333.8 4338.8 6089.8 6102.8 6120.9 6197.3 6202.7 4248.5 4267.2 4275.2 4279.5 4293.7 4339.6 4355.4 4361.4 4361.9 4377.3 4866.6 4988.1 5010.4 5025.2 5042.5 5948.4 5954.7 5990.2 5995.5 6015.2 1507.4 1512.7 1515.7 1520.1 1520.7 951.2 973.6 980.7 983.6 995.7 5199.4 5222.9 5240.0 5255.7 5309.9 5445.3 5505.5 5507.7 5513.9 5561.4 4930.6 5193.0 5222.6 5222.9 5248.3 2905.2 2924.1 2930.8 2955.1 2958.6 5705.2 5705.9 5759.8 5779.0 5803.4 5181.6 5464.0 5579.2 5586.5 5598.2 5539.8 5729.5 5752.5 5760.3 5776.8 5127.1 5457.3 5475.0 5509.2 5588.7 5391.7 5469.4 5486.6 5521.4 5826.4 6302.6 6318.7 6454.5 6466.3 6488.6 4327.3 4387.0 4392.0 4393.6 4406.7 5921.3 6192.3 6222.3 6263.8 6291.4 5997.8 6044.2 6091.9 6096.2 6101.2 5801.0 6053.9 6069.7 6070.5 6089.9 5933.4 5950.5 5978.4 5985.3 5986.2 6060.7 6070.5 6070.9 6073.9 6096.3 5651.4 5947.4 5949.0 5963.5 5980.0 23:42:04 INFO - PROCESS | 28917 | 23:42:04 INFO - PROCESS | 28917 | [#5] yui.html Cycles:180 Average:20323.72 Median:4042.17 stddev:27565.62 (682.0%) stddev-sans-first:27603.95 23:42:04 INFO - PROCESS | 28917 | Values: 797.8 817.7 863.9 869.4 911.0 15656.4 15697.2 15859.2 15889.6 15899.7 14253.4 14302.4 14309.0 14402.6 14429.8 835.7 837.5 841.5 844.3 848.7 836.4 843.0 843.4 843.9 844.7 888.5 892.8 893.2 895.2 899.0 879.0 882.6 886.0 887.1 889.7 646.2 651.1 651.8 652.6 656.0 14703.3 14718.1 14756.6 14787.0 14845.3 13367.1 13486.5 13501.3 13526.1 13562.2 12032.3 12263.9 12274.4 12333.0 12349.6 4005.9 4041.9 4083.0 4149.1 4208.4 55349.0 65954.7 66707.3 68787.7 77152.6 12904.1 13036.5 13064.8 13070.8 13246.7 24379.3 24429.4 24467.4 24481.9 24510.6 8881.8 8920.1 8928.5 9039.6 9168.7 4963.4 5072.8 5097.8 5115.9 5193.9 3935.2 3988.3 4014.8 4027.3 4042.5 726.2 739.1 742.2 747.3 762.4 627.9 703.0 746.9 768.9 780.4 10905.8 10996.9 11177.3 11370.9 11580.8 760.8 769.8 772.4 783.8 789.3 5070.2 5151.9 5195.9 5207.3 5225.0 76875.6 77217.0 77224.2 89255.0 90569.5 108576.0 108964.0 111356.0 112871.0 113148.0 65958.7 73645.0 74929.0 84021.6 87761.0 10487.6 10559.2 10668.5 10795.2 10965.8 54601.2 55046.7 55124.4 55329.4 55626.0 72719.6 75626.6 76964.0 77358.6 77432.0 13460.7 13883.0 14003.2 14062.7 14094.8 15796.6 15954.9 16057.4 16752.6 16993.7 13883.2 14570.3 14669.7 15287.4 15363.2 14001.9 14198.5 14352.6 14446.0 14635.6 14256.4 14589.7 14607.2 14875.6 15009.8 11684.0 11871.2 11944.6 12036.2 12272.5 12310.6 12501.2 12686.1 12838.2 13081.5 23:42:04 INFO - PROCESS | 28917 | -------- Summary: end -------- 23:42:04 INFO - PROCESS | 28917 | 23:42:05 INFO - TEST-INFO | 28917: exit 0 23:42:05 INFO - TEST-OK | dromaeo_css | took 1110244ms 23:42:05 INFO - TEST-START | kraken 23:42:05 INFO - operating with platform_type : linux_ 23:42:05 INFO - Initialising browser for kraken test... 23:42:05 INFO - TEST-INFO | started process 29161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWLVRHu/profile http://localhost:59563/getInfo.html) 23:42:09 INFO - PROCESS | 29161 | __metrics Screen width/height:1600/1200 23:42:09 INFO - PROCESS | 29161 | colorDepth:24 23:42:09 INFO - PROCESS | 29161 | Browser inner width/height: 1024/697 23:42:09 INFO - PROCESS | 29161 | __metrics 23:42:10 ERROR - PROCESS | 29161 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:42:11 INFO - TEST-INFO | 29161: exit 0 23:42:11 INFO - Browser initialized. 23:42:11 INFO - Running cycle 1/1 for kraken test... 23:42:11 INFO - TEST-INFO | started process 29289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWLVRHu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:42:23 INFO - PROCESS | 29289 | RSS: Main: 156155904 23:42:23 INFO - PROCESS | 29289 | 23:42:25 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59563/tests/kraken/driver.html?testName=audio-beat-detection) 23:42:26 INFO - PROCESS | 29289 | RSS: Main: 161386496 23:42:26 INFO - PROCESS | 29289 | 23:42:29 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59563/tests/kraken/driver.html?testName=audio-dft) 23:42:29 INFO - PROCESS | 29289 | RSS: Main: 160899072 23:42:29 INFO - PROCESS | 29289 | 23:42:32 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59563/tests/kraken/driver.html?testName=audio-fft) 23:42:33 INFO - PROCESS | 29289 | RSS: Main: 161468416 23:42:33 INFO - PROCESS | 29289 | 23:42:35 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59563/tests/kraken/driver.html?testName=audio-oscillator) 23:42:35 INFO - PROCESS | 29289 | RSS: Main: 160813056 23:42:35 INFO - PROCESS | 29289 | 23:42:38 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59563/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:42:38 INFO - PROCESS | 29289 | RSS: Main: 161026048 23:42:38 INFO - PROCESS | 29289 | 23:42:41 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59563/tests/kraken/driver.html?testName=imaging-darkroom) 23:42:42 INFO - PROCESS | 29289 | RSS: Main: 160751616 23:42:42 INFO - PROCESS | 29289 | 23:42:45 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59563/tests/kraken/driver.html?testName=imaging-desaturate) 23:42:46 INFO - PROCESS | 29289 | RSS: Main: 157700096 23:42:46 INFO - PROCESS | 29289 | 23:42:49 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59563/tests/kraken/driver.html?testName=json-parse-financial) 23:42:49 INFO - PROCESS | 29289 | RSS: Main: 159141888 23:42:49 INFO - PROCESS | 29289 | 23:42:51 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59563/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:42:52 INFO - PROCESS | 29289 | RSS: Main: 159387648 23:42:52 INFO - PROCESS | 29289 | 23:42:53 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59563/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:42:54 INFO - PROCESS | 29289 | RSS: Main: 159768576 23:42:54 INFO - PROCESS | 29289 | 23:42:56 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59563/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:42:57 INFO - PROCESS | 29289 | RSS: Main: 159813632 23:42:57 INFO - PROCESS | 29289 | 23:42:59 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:43:00 INFO - PROCESS | 29289 | RSS: Main: 160239616 23:43:00 INFO - PROCESS | 29289 | 23:43:03 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:43:03 INFO - PROCESS | 29289 | RSS: Main: 160002048 23:43:03 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | Cycle 1(1): loaded http://localhost:59563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59563/tests/kraken/driver.html?testName=ai-astar) 23:43:05 INFO - PROCESS | 29289 | RSS: Main: 160923648 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | __start_tp_report 23:43:05 INFO - PROCESS | 29289 | _x_x_mozilla_page_load 23:43:05 INFO - PROCESS | 29289 | _x_x_mozilla_page_load_details 23:43:05 INFO - PROCESS | 29289 | |i|pagename|runs| 23:43:05 INFO - PROCESS | 29289 | |0;ai-astar;111;105;109;109;112;110;110;109;109;109 23:43:05 INFO - PROCESS | 29289 | |1;audio-beat-detection;155;135;156;174;127;159;162;134;179;125 23:43:05 INFO - PROCESS | 29289 | |2;audio-dft;164;163;162;166;163;163;163;163;162;163 23:43:05 INFO - PROCESS | 29289 | |3;audio-fft;79;76;76;180;77;76;76;75;173;76 23:43:05 INFO - PROCESS | 29289 | |4;audio-oscillator;86;86;147;87;84;86;134;86;85;151 23:43:05 INFO - PROCESS | 29289 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;117;117;117 23:43:05 INFO - PROCESS | 29289 | |6;imaging-darkroom;150;147;147;147;148;149;147;147;148;146 23:43:05 INFO - PROCESS | 29289 | |7;imaging-desaturate;96;95;95;95;95;96;95;96;95;95 23:43:05 INFO - PROCESS | 29289 | |8;json-parse-financial;55;53;53;58;53;54;53;53;53;53 23:43:05 INFO - PROCESS | 29289 | |9;json-stringify-tinderbox;60;59;60;60;60;60;59;60;59;60 23:43:05 INFO - PROCESS | 29289 | |10;stanford-crypto-aes;77;76;76;82;79;78;81;77;108;78 23:43:05 INFO - PROCESS | 29289 | |11;stanford-crypto-ccm;118;126;133;118;116;122;118;135;140;134 23:43:05 INFO - PROCESS | 29289 | |12;stanford-crypto-pbkdf2;158;161;157;154;155;155;153;156;155;152 23:43:05 INFO - PROCESS | 29289 | |13;stanford-crypto-sha256-iterative;63;65;61;63;62;62;63;61;64;62 23:43:05 INFO - PROCESS | 29289 | __end_tp_report 23:43:05 INFO - PROCESS | 29289 | __start_cc_report 23:43:05 INFO - PROCESS | 29289 | _x_x_mozilla_cycle_collect,881 23:43:05 INFO - PROCESS | 29289 | __end_cc_report 23:43:05 INFO - PROCESS | 29289 | __startTimestamp1468478585509__endTimestamp 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | ------- Summary: start ------- 23:43:05 INFO - PROCESS | 29289 | Number of tests: 14 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#0] ai-astar Cycles:10 Average:109.30 Median:109.50 stddev:1.83 (1.7%) stddev-sans-first:1.83 23:43:05 INFO - PROCESS | 29289 | Values: 111.0 105.0 109.0 109.0 112.0 110.0 110.0 109.0 109.0 109.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:157.50 stddev:19.25 (12.2%) stddev-sans-first:20.35 23:43:05 INFO - PROCESS | 29289 | Values: 155.0 135.0 156.0 174.0 127.0 159.0 162.0 134.0 179.0 125.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 23:43:05 INFO - PROCESS | 29289 | Values: 164.0 163.0 162.0 166.0 163.0 163.0 163.0 163.0 162.0 163.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#3] audio-fft Cycles:10 Average:96.40 Median:76.00 stddev:42.26 (55.6%) stddev-sans-first:44.35 23:43:05 INFO - PROCESS | 29289 | Values: 79.0 76.0 76.0 180.0 77.0 76.0 76.0 75.0 173.0 76.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:86.00 stddev:28.48 (33.1%) stddev-sans-first:29.51 23:43:05 INFO - PROCESS | 29289 | Values: 86.0 86.0 147.0 87.0 84.0 86.0 134.0 86.0 85.0 151.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:43:05 INFO - PROCESS | 29289 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.17 (0.8%) stddev-sans-first:0.87 23:43:05 INFO - PROCESS | 29289 | Values: 150.0 147.0 147.0 147.0 148.0 149.0 147.0 147.0 148.0 146.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 23:43:05 INFO - PROCESS | 29289 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.00 stddev:1.62 (3.1%) stddev-sans-first:1.66 23:43:05 INFO - PROCESS | 29289 | Values: 55.0 53.0 53.0 58.0 53.0 54.0 53.0 53.0 53.0 53.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 23:43:05 INFO - PROCESS | 29289 | Values: 60.0 59.0 60.0 60.0 60.0 60.0 59.0 60.0 59.0 60.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:78.00 stddev:9.62 (12.3%) stddev-sans-first:10.09 23:43:05 INFO - PROCESS | 29289 | Values: 77.0 76.0 76.0 82.0 79.0 78.0 81.0 77.0 108.0 78.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:129.50 stddev:8.81 (6.8%) stddev-sans-first:8.85 23:43:05 INFO - PROCESS | 29289 | Values: 118.0 126.0 133.0 118.0 116.0 122.0 118.0 135.0 140.0 134.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:155.50 stddev:2.59 (1.7%) stddev-sans-first:2.60 23:43:05 INFO - PROCESS | 29289 | Values: 158.0 161.0 157.0 154.0 155.0 155.0 153.0 156.0 155.0 152.0 23:43:05 INFO - PROCESS | 29289 | 23:43:05 INFO - PROCESS | 29289 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.26 (2.0%) stddev-sans-first:1.33 23:43:05 INFO - PROCESS | 29289 | Values: 63.0 65.0 61.0 63.0 62.0 62.0 63.0 61.0 64.0 62.0 23:43:05 INFO - PROCESS | 29289 | -------- Summary: end -------- 23:43:05 INFO - PROCESS | 29289 | 23:43:06 INFO - TEST-INFO | 29289: exit 0 23:43:06 INFO - TEST-OK | kraken | took 61400ms 23:43:06 INFO - SUITE-END | took 1171s 23:43:06 INFO - Completed test suite (00:19:31) 23:43:06 INFO - javascript benchmark 23:43:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7553.238749921677, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3275.9680700579315, 3312.470004799233, 3338.0152854907806, 3356.1945133168047, 3362.3275344931003, 5546.4453554644515, 5559.833205003852, 5570.0, 5574.219609254707, 5591.049521581331, 5578.191162281467, 5607.57943154264, 5630.324361076667, 5650.29371328584, 5656.547476201904, 5084.034033533635, 5152.793888244466, 5164.535191832734, 5172.09488339541, 5203.19350500673, 5088.7964481420695, 5101.15830887903, 5221.686698798066, 5229.921551176735, 5261.316028916235, 5087.643864929457, 5111.08000559899, 5148.665336753118, 5153.69077855328, 5208.973955130219, 5158.48415158483, 5172.482751724835, 5188.0, 5228.581713462914, 5266.973665131688, 4986.700797952134, 5086.949130508721, 5160.071187186305, 5200.713960732158, 5218.321618189611, 5425.077736784717, 5430.185472179165, 5461.481159289861, 5510.834674959758, 5534.4742249486235, 5943.3165186003735, 5981.461668449861, 5991.131285963511, 5997.22036135304, 6000.669963152025, 5871.031279838864, 5938.435848594377, 6030.09548567714, 6030.427109424598, 6044.395560443964, 5598.300212473441, 5689.857753556194, 5692.57305702074, 5707.6290041147195, 5728.51307638847, 6136.110264011693, 6154.3845615438095, 6163.630182189083, 6167.136600875881, 6171.444569988723, 5767.22142510764, 5844.444777746107, 5859.355470898197, 5924.844655292263, 5932.822015339547, 6017.097435384728, 6019.0, 6021.969890150609, 6037.698115094316, 6051.152838602599, 5952.285725712942, 5965.671888046112, 5986.46121849027, 6001.159837622737, 6017.097435384728, 5752.539796816244, 5885.61743486672, 5905.409459054146, 5923.318818335946, 6005.909911351333, 4572.611328037087, 4587.3807036050375, 4604.0, 4604.631629469634, 4612.192866248393, 4093.692973027035, 4105.035316700573, 4107.342825147962, 4123.546409894909, 4144.026153853842, 5658.943410565924, 5745.798897038583, 5782.2483077199695, 5813.0, 5861.501772349398, 5925.0, 5973.223480947536, 6001.12983617373, 6005.588686658632, 6053.0, 5652.519535839418, 5777.711114444261, 5788.594798364158, 5792.333881603585, 5801.158831969341, 5066.341375621219, 5107.310513080761, 5117.437081920985, 5136.0241554104605, 5140.203268493389, 6173.382661733791, 6183.381661833871, 6241.469475094668, 6266.843328916722, 6282.560220784501, 5885.14665373527, 5998.970005149947, 6046.244219472566, 6048.485878700271, 6050.45545900871, 6177.96911015442, 6234.75060997555, 6256.374362563707, 6283.905741413791, 6326.620402775849, 5833.358330583547, 5956.851078722893, 5964.045752679551, 5972.800111753075, 6001.0, 5871.354151043296, 5935.643861368331, 5937.435943585352, 6048.637081775108, 6081.027035674271, 5856.824295271149, 5886.646801191942, 5888.205092312654, 5890.0, 5898.203742494708, 5854.180414741854, 5867.471927526543, 5897.941020589739, 5901.940980590311, 5909.70451477433, 5578.693171875586, 5768.134779783066, 5777.306723193244, 5801.36185019639, 5825.0, 5922.378150294157, 5924.289085309618, 5956.166136740773, 5967.671778052249, 5984.910226346696, 5839.065749480063, 5845.064789633639, 5846.239988801429, 5856.267966504187, 5860.912086318794], "value": 5549.421154753296, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.331412132533, 647.3300134360937, 661.9040239165319, 667.5527396644247, 681.6421378776145, 40730.0, 45627.08745825082, 46150.53849461509, 46181.53818461814, 46658.53341466584, 45882.541174588245, 47400.52599474004, 47431.76284118583, 47504.0, 47795.0, 8968.192862642361, 9014.954925225366, 9077.863832042525, 9089.363744537884, 9094.045125261851, 8983.910160898373, 9049.095090490931, 9082.636694532212, 9089.95465521467, 9096.909030909672, 9109.0, 9138.223251023672, 9140.497272650035, 9179.0, 9184.724458266262, 9005.459672419644, 9073.36486445949, 9077.45535267886, 9115.81768364629, 9136.132067453647, 8930.955345223298, 8993.325500587416, 9006.189442950166, 9055.637774489078, 9058.139476749764, 42759.35860962088, 42807.35788963168, 42808.3578746319, 42965.57034429678, 43196.0, 3728.5898551159353, 3742.2141350316465, 3787.6780473659774, 3821.216650586623, 4084.7140700151003, 34105.829470852485, 34732.30535389303, 34863.4770478443, 34920.65079349225, 34937.0, 4355.0, 4408.713433626804, 4413.0732546165345, 4450.866474005785, 4480.8879778005485, 354917.0, 354982.0, 356522.21738891397, 356602.0, 357217.0, 61726.0, 61839.38160618426, 62341.376586234466, 62381.37618623846, 62570.0, 39066.218675626325, 40075.59924400777, 40114.799426003265, 42387.364189537184, 42499.57500425018, 16348.836511634732, 16412.589685257724, 16452.259648315616, 16546.66906661884, 16578.75131873023, 12205.633830985085, 12333.75332493363, 12353.876461235273, 12375.75248495043, 12384.690382740504, 20925.26761563338, 20937.05783239758, 21134.88651134905, 21365.893170534047, 21369.358919232447, 7579.2420757924865, 7876.17300183484, 7887.723929662434, 8017.839643207103, 8018.799530011796, 997.0826839307854, 1061.3737894642197, 1075.2580719303655, 1095.9890401096047, 1132.824412216108, 32499.675003250137, 32539.34921301608, 32669.346613067606, 33151.3369732604, 33192.0, 1120.120705246394, 1159.0437888741653, 1168.1472525056756, 1175.1832476428972, 1178.4049055227056, 17343.826561734473, 17412.651746964988, 17478.563035923948, 17573.472795816146, 17678.0, 159380.20309898377, 562267.0, 572473.0, 636408.0, 641071.0, 59993.70003149956, 60623.69688151531, 60777.08834367488, 60974.695126524086, 60998.39001609927, 1460.5399299220712, 1479.578320178744, 1493.6041948883556, 1497.5357639131687, 1506.3296832909468, 31320.843395782875, 31412.214694631904, 31556.36887262288, 31817.840910795298, 32511.51232731558, 50371.49628503815, 50649.0, 50660.74669626628, 50796.74601626968, 50987.0, 411040.0, 416172.0, 419551.0, 419964.0, 420844.0, 29518.0, 29627.703722963357, 29834.0, 29969.70030299669, 29983.70016299809, 47286.52713472821, 47993.0, 48081.278780817614, 48762.26856597083, 48862.26706599333, 39587.406188906614, 40329.0, 40436.393454097626, 40518.0, 41309.38035929524, 39016.80491597524, 39828.60171398249, 40088.1982360357, 40115.0, 40914.0, 39640.80179599083, 40416.19167616573, 40737.0, 40759.79620101999, 41087.589124109574, 34122.658773411946, 35043.12392190113, 35613.465798012534, 36640.0, 38404.0, 29595.85202073976, 30139.246518836328, 30193.547096794005, 30551.0, 30718.84640576783], "value": 20439.52791192048, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.1709167124109, 427.32696003793995, 427.3738972405426, 428.30828212436916, 448.17312059250673, 18801.71797423038, 20033.899830500864, 20706.482337941557, 21319.36041918741, 21332.57334853302, 17364.913175434103, 17631.64736705265, 17972.460826175236, 18142.546436339064, 18144.45566633, 5616.297962754656, 5991.820245392623, 6000.939990600082, 6022.096685497188, 6028.4574388305045, 5498.340199176105, 5783.103618939072, 5879.941200587982, 5907.852303692421, 5953.3451320354725, 5776.451237132465, 5822.359540450547, 5848.210491583645, 5862.765489380419, 5901.822945311647, 5704.515116215127, 6009.06859436788, 6009.308929473101, 6011.969940150315, 6013.51891848651, 5679.062954612484, 5808.448197421239, 5828.125781132821, 5843.415658434165, 5852.414758524156, 14909.105453672815, 15009.924950375178, 15108.0, 22009.779902200935, 24795.87602061978, 2329.429289823987, 2342.519783444407, 2462.827602067856, 2504.8747562621797, 2584.4185058361904, 10904.50929708165, 11048.392338421383, 11104.888951110466, 11263.66209013731, 11282.097432205404, 1955.7946415626297, 2077.418322869599, 2125.5855108253895, 2165.1880544795704, 2179.1129389181974, 77667.61166194132, 82132.0, 84765.0, 86484.13515864823, 88761.0, 11611.0, 11808.642006169228, 12075.154739168174, 12182.0, 12188.390580470941, 17101.828981710274, 17270.050147242022, 17337.913310433367, 17362.91318543399, 17434.12829358527, 8121.593920303962, 8254.628541715638, 8296.419250652518, 8437.915620843836, 8566.443181193203, 7556.282153195438, 7759.72840950564, 7872.803179920434, 7951.204879512003, 7987.480813747088, 4903.092927808367, 5047.848564543069, 5094.465081166498, 5214.374275086938, 5345.0, 2050.7797860273113, 2114.492521794758, 2134.711813905103, 2138.550904310081, 2159.66525188596, 995.8356871116184, 1042.6142327338932, 1115.297362661518, 1124.2579897267765, 1132.9830052549219, 19952.0, 20186.09162587687, 20365.592688146153, 20400.0, 20439.386818395473, 1085.5708708469426, 1087.9782404351868, 1102.443266150589, 1110.677903408019, 1123.5898896902736, 11314.264572802742, 11325.0, 11449.54201831934, 11526.711832204262, 11587.14023758269, 488292.0, 494764.0, 495050.0, 505940.0, 506960.0, 91503.54248228716, 93234.0, 96755.51622241843, 101057.0, 101500.0, 495.34366963772425, 511.15659162382366, 518.4659800405589, 519.7713006277302, 520.0093821270561, 11448.427578621202, 11815.881841181477, 12167.574134905235, 12248.448819803309, 12546.811797822857, 43048.0, 43058.354124687525, 44528.33207501955, 44755.552444475135, 45513.54486455093, 60941.69529152503, 61230.693846530485, 61686.0, 63703.6814815923, 63710.0, 9312.48781317034, 9335.719928402159, 9379.484128373006, 9667.0, 9682.70951871445, 10244.59021639156, 13882.16706997543, 13928.442862285396, 13958.09272397291, 14113.2943352834, 11993.34036627959, 12529.624111276677, 12672.809907851206, 12808.295543745184, 12857.0, 12025.579104731292, 12305.815412768994, 12308.876911230773, 12359.62921112368, 12631.557895473614, 12617.684557886127, 12641.0, 12716.109872308849, 12763.361831908182, 12844.550440734904, 9466.479343636167, 9469.14777670013, 9489.76275593088, 9590.42457452555, 9596.328257021942, 9894.455804930798, 12685.302308373128, 12772.233665980071, 12871.678208044874, 12875.935620321838], "value": 9360.16738847025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1562.2188905547227, 1588.4361051826602, 1791.2208189437595, 1875.4373687893628, 1895.5829717462154, 9163.541822908854, 9561.569729362178, 9800.85298720519, 9821.165200957917, 9828.655997040105, 9816.852747208797, 9984.700458986243, 9986.550605222765, 10022.899771002289, 10106.09045185933, 2500.974990250097, 2534.619807028951, 2543.656606358146, 2544.185860524633, 2549.5028469448466, 2507.335556077641, 2572.0740533407957, 2581.1998280533094, 2586.4180559374176, 2588.637590737298, 2381.499885024138, 2407.9518409631796, 2468.7778099971, 2478.330850670318, 2481.727010028895, 2438.0735320578156, 2443.315871555967, 2470.1231062972656, 2476.925692229236, 2483.5653760592004, 2430.501747141832, 2451.681281433402, 2467.481828815951, 2472.11004038546, 2486.0, 9725.027497250288, 9835.557399917021, 9849.852252216222, 9850.50747462631, 9850.655227067018, 5492.917606235909, 5571.721413929328, 5584.944150558483, 5599.608027438081, 5625.5218306444, 3693.815309234554, 3764.9058773530605, 3843.0584506796013, 3859.710521710883, 3872.7289089763726, 1225.5771758743308, 1231.3904617214537, 1241.9068569857207, 1280.5262053040342, 1302.2446980751142, 12576.68558286041, 12866.356682165855, 12873.742525149539, 12910.22538647684, 12961.351932403342, 4965.32968049316, 5106.744662766847, 5108.514691104339, 5112.693238405707, 5163.845084647466, 11285.492152853141, 11382.317060976367, 11418.42907854604, 11446.599369022044, 11447.656570302905, 5524.392316845144, 5546.27898373217, 5556.499915007668, 5609.298837645294, 5612.550995920316, 4364.912701745948, 4867.3915760529935, 5025.070361983045, 5028.748562571856, 5034.06869729094, 4256.0, 4302.376155457441, 4338.566143385636, 4353.69524133314, 4384.539623339503, 1345.710672205461, 1377.442135934948, 1384.7922811578142, 1386.1475192756584, 1395.9371828267751, 1048.1719441641171, 1076.1874784537624, 1094.8248280275277, 1104.1553211792984, 1131.7510147767478, 6304.716287767062, 6506.4469520091325, 6514.3811337922825, 6622.569532980341, 6668.266490686021, 462.854200926707, 471.4719514144181, 478.394830539368, 489.52516059422305, 490.872373182975, 4537.274036154199, 4584.770761461914, 4608.907821843544, 4609.792559334838, 4621.376114224537, 11185.832212516818, 11463.598774042868, 11463.656090317303, 11463.885361146282, 11472.713182170513, 11283.0, 11361.204715669825, 11397.658070257905, 11774.764504709858, 11793.823092653616, 8882.378233523721, 9058.365914386062, 9073.500957447404, 9091.863622045674, 9100.544972751335, 6668.566543174678, 6732.5907778980245, 6764.49266305039, 6891.586504809728, 7009.0, 11113.166512511432, 11143.665690029313, 11165.609203677832, 11176.0, 11472.0, 11194.328340299608, 11542.480588373375, 11621.5351385947, 11669.649910502698, 11704.0, 7792.454528182972, 8223.136570659995, 8492.193241642035, 8632.827343453222, 8770.649174033222, 9557.522123893916, 9593.42439453635, 9608.183304419203, 9628.0, 9672.516374181403, 8451.66193352259, 8583.442076265022, 8624.52565108925, 8648.135186481302, 8683.305335573014, 8283.50298982063, 8313.792155196168, 8461.576921154041, 8462.407631465738, 8510.574471276535, 7877.448578599443, 7932.444728868923, 7998.000249968754, 8006.919930800617, 8013.2387423194705, 5650.802221922213, 5709.400512946247, 5806.4483874033585, 5841.1238314253205, 5852.970735146297, 5700.486956173964, 5705.058665320175, 5718.1136923776885, 5730.451757384874, 5783.045797443375], "value": 4982.771553686269, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.467526697054, 353.04853420033015, 358.64315006568467, 359.10045336432233, 359.63497050493754, 5750.424957504248, 5759.856003599902, 5783.479486846183, 5799.072148456248, 5806.796762113321, 5633.352164501083, 5635.6055076144685, 5638.182463542794, 5640.238567793357, 5654.886902261952, 4277.272863613185, 4378.102488989765, 4388.86833394997, 4393.626541743955, 4431.401760762305, 4366.694331396803, 4416.492103408117, 4426.269665505188, 4429.490608580022, 4442.222611043071, 4367.934480982788, 4387.7367357958465, 4388.341748737699, 4394.07724377881, 4397.230484665187, 4281.871543853674, 4363.498197707273, 4368.672349573794, 4374.278244089722, 4410.338449232609, 3803.3154032274456, 3803.581606023363, 3821.9617803821884, 3825.7513261637905, 3831.04223944014, 5508.4491550845, 5513.862153446155, 5521.4478552144865, 5533.22534845122, 5587.469190426903, 4902.730349830794, 5004.172642457036, 5022.874428139289, 5025.497450254982, 5052.974735126338, 5849.883002339972, 5861.85345366365, 5924.940750592482, 5932.644041357532, 5941.0, 4312.892177695551, 4322.6325762309925, 4324.286492728696, 4333.848315308949, 4338.783060846945, 6089.751600921801, 6102.755889764404, 6120.877582448371, 6197.287311959138, 6202.720877560476, 4248.532661407243, 4267.231898258343, 4275.166342563232, 4279.507856596469, 4293.720908140961, 4339.63113135387, 4355.390245365651, 4361.411209486679, 4361.890952726208, 4377.321515165155, 4866.562009419169, 4988.12707776145, 5010.423801262901, 5025.246213067996, 5042.520960508746, 5948.434898684618, 5954.702264886739, 5990.221271234712, 5995.46040856325, 6015.187949626745, 1507.366905899525, 1512.6672132130914, 1515.6514001779653, 1520.1335238913714, 1520.711064897688, 951.1914872358578, 973.561897146287, 980.6567701304486, 983.5573991703762, 995.6515219673056, 5199.428062913076, 5222.947770522323, 5239.973800130975, 5255.658382205144, 5309.920351194735, 5445.264889239981, 5505.4584716279505, 5507.7246137692955, 5513.917291240635, 5561.443855614487, 4930.605551555867, 5192.9740351298005, 5222.556082732935, 5222.895542089137, 5248.343957005374, 2905.17202597263, 2924.1081470151385, 2930.7508861746564, 2955.138262894363, 2958.6301712285963, 5705.2012718219485, 5705.857353566194, 5759.798407055733, 5779.0, 5803.419658034163, 5181.637285389987, 5464.0, 5579.246801681721, 5586.469285417878, 5598.216249725042, 5539.845116162878, 5729.512991395778, 5752.539796816244, 5760.337561180434, 5776.8048141705885, 5127.051495473349, 5457.263269458731, 5475.0, 5509.162781167622, 5588.714595642944, 5391.7304134793885, 5469.398366179637, 5486.61593688438, 5521.3926468087675, 5826.359100498857, 6302.550413405034, 6318.652474113968, 6454.548181627241, 6466.256380516113, 6488.643124628191, 4327.264365057885, 4386.990992071906, 4391.956080439155, 4393.582609652206, 4406.691531592758, 5921.3190483094995, 6192.349803270772, 6222.253329600477, 6263.843403914939, 6291.402316779899, 5997.760089596367, 6044.24446944132, 6091.928744226984, 6096.22621707131, 6101.176341194059, 5800.984827655059, 6053.878922421615, 6069.726862291119, 6070.453659170696, 6089.9342615041305, 5933.418962751217, 5950.494207992369, 5978.3722709116655, 5985.25184351956, 5986.2217911671205, 6060.727267272895, 6070.48400885912, 6070.876887775776, 6073.937061014393, 6096.29892562361, 5651.400355836361, 5947.434993675594, 5948.970255148696, 5963.522918166623, 5979.970100149471], "value": 4431.148492025804, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.7806103321586, 817.7464985854382, 863.8709741334048, 869.4218344800706, 910.9863352049719, 15656.3737450502, 15697.215139243035, 15859.207039648, 15889.602759931007, 15899.68200635988, 14253.429862805502, 14302.427902883872, 14309.0, 14402.567922962302, 14429.783553246709, 835.6740871060276, 837.539353355652, 841.4824882697128, 844.2992316377392, 848.6690190825583, 836.431226765799, 843.0178841649501, 843.4475418600827, 843.9198276163754, 844.6832437835811, 888.4802390601506, 892.8437523433406, 893.1648908270788, 895.2390468102126, 898.9550522473883, 878.97802554936, 882.6160620130232, 886.02979737188, 887.0685779931047, 889.7197382824389, 646.214848958513, 651.1112331667288, 651.8240075179723, 652.6280020388381, 655.9672016399209, 14703.33834977418, 14718.116912985148, 14756.631084222872, 14787.0, 14845.257737113101, 13367.131136476195, 13486.527971520949, 13501.2574308413, 13526.120802147927, 13562.186268823902, 12032.27806331623, 12263.877361226363, 12274.447649855689, 12333.0, 12349.567765128268, 4005.919881602352, 4041.8585349512628, 4082.9591704082877, 4149.087200815816, 4208.431861698693, 55349.0, 65954.67022664905, 66707.3329266706, 68787.65606171938, 77152.61423692845, 12904.096713230172, 13036.54372096991, 13064.804027939588, 13070.803937940938, 13246.668833279246, 24379.26862194137, 24429.38926526851, 24467.38831529226, 24481.877590611934, 24510.632340514905, 8881.777955551033, 8920.107989201028, 8928.464292142493, 9039.593218305192, 9168.679096231734, 4963.404391473046, 5072.82245121419, 5097.8215762448135, 5115.897682046339, 5193.948060519422, 3935.193285376491, 3988.2621714982242, 4014.7791871447353, 4027.3354896442347, 4042.4744783178, 726.179417258505, 739.1352118021928, 742.157651066044, 747.3460721868365, 762.3520007993161, 627.8901192291331, 702.9859402811915, 746.8655641984386, 768.9465432357593, 780.4068907630128, 10905.83641245382, 10996.890031099747, 11177.273477223955, 11370.886291137149, 11580.826287605692, 760.8174038230785, 769.8037000564821, 772.4052479590683, 783.7844592736928, 789.2659826361424, 5070.2141168119, 5151.871203219949, 5195.922061169085, 5207.3230480037355, 5224.9738751306, 76875.61562192153, 77217.0, 77224.2277577217, 89255.0, 90569.54715226381, 108576.0, 108964.0, 111356.0, 112871.0, 113148.0, 65958.67020664866, 73645.0, 74929.0, 84021.57989210016, 87761.0, 10487.632932847313, 10559.155267578422, 10668.519916603616, 10795.190360723134, 10965.83551246716, 54601.1809822845, 55046.72476637591, 55124.448755513535, 55329.44670553404, 55626.0, 72719.63640181765, 75626.62186689032, 76964.0, 77358.6132069336, 77432.0, 13460.663483412993, 13883.0, 14003.159810411407, 14062.718745625234, 14094.788578171541, 15796.60508487297, 15954.920225398799, 16057.437989670305, 16752.58118546997, 16993.66012679715, 13883.236421996888, 14570.271486425425, 14669.70660586761, 15287.388504459697, 15363.23183840826, 14001.929990349983, 14198.503052393116, 14352.56942291733, 14446.0, 14635.634109147357, 14256.42974281017, 14589.708205836036, 14607.19660418687, 14875.628109297355, 15009.849901501282, 11684.0, 11871.228370155912, 11944.581939632071, 12036.157468977088, 12272.509099635914, 12310.569130080405, 12501.187422817487, 12686.111972162229, 12838.191004803892, 13081.542146024844], "value": 7920.797797472727, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 109.0, 109.0, 112.0, 110.0, 110.0, 109.0, 109.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 135.0, 156.0, 174.0, 127.0, 159.0, 162.0, 134.0, 179.0, 125.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 166.0, 163.0, 163.0, 163.0, 163.0, 162.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 76.0, 180.0, 77.0, 76.0, 76.0, 75.0, 173.0, 76.0], "value": 96.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 147.0, 87.0, 84.0, 86.0, 134.0, 86.0, 85.0, 151.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 147.0, 147.0, 148.0, 149.0, 147.0, 147.0, 148.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 58.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 82.0, 79.0, 78.0, 81.0, 77.0, 108.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 126.0, 133.0, 118.0, 116.0, 122.0, 118.0, 135.0, 140.0, 134.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 157.0, 154.0, 155.0, 155.0, 153.0, 156.0, 155.0, 152.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 61.0, 63.0, 62.0, 62.0, 63.0, 61.0, 64.0, 62.0], "value": 62.6, "unit": "score"}]}]} 23:43:06 INFO - Return code: 0 23:43:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:43:06 ERROR - # TBPL SUCCESS # 23:43:06 INFO - Running post-action listener: _resource_record_post_action 23:43:06 INFO - ##### 23:43:06 INFO - ##### Finished run-tests step (success) 23:43:06 INFO - ##### 23:43:06 INFO - Running post-run listener: _resource_record_post_run 23:43:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 504721408; Read time: 32; Write time: 487704 23:43:06 INFO - TinderboxPrint: CPU usage
13.5% 23:43:06 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 23:43:06 INFO - TinderboxPrint: I/O write bytes / time
504,721,408 / 487,704 23:43:06 INFO - TinderboxPrint: CPU idle
8,209.3 (86.5%) 23:43:06 INFO - TinderboxPrint: CPU user
1,218.3 (12.8%) 23:43:06 INFO - TinderboxPrint: Swap in / out
0 / 0 23:43:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252784640; Read time: 0; Write time: 329424 23:43:06 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251936768; Read time: 32; Write time: 158280 23:43:07 INFO - Running post-run listener: _upload_blobber_files 23:43:07 INFO - Blob upload gear active. 23:43:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:43:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:43:07 INFO - (blobuploader) - INFO - Open directory for files ... 23:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:08 INFO - (blobuploader) - INFO - Done attempting. 23:43:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:43:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:12 INFO - (blobuploader) - INFO - Done attempting. 23:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:13 INFO - (blobuploader) - INFO - Done attempting. 23:43:13 INFO - (blobuploader) - INFO - Iteration through files over. 23:43:13 INFO - Return code: 0 23:43:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:43:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:43:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abe3ea12e4a0d56dffff28c2e47c7b07fa1e74c6429535aa57ada08c9c1c3da35893aeb6c12e1a0a3bed224982f27321b9ceb1f4b69b3a8235a4f80c5b94efff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c7efe57560281ba78396e2b9c3ae665178e7523723abe0cb47c47090480c77e5d7d4b6fffb0485b5fe88669c095e62959aa94ea256041989db557204a53eaf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccb910e96b3d17e73a4ce30f31aa3498500908a80fdea3ce9c0a00a2ae6584e562103049aad66b17e4d59dc16398dd31f641147d6c259250d57a9bceb17d22d9"} 23:43:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:43:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:43:13 INFO - Contents: 23:43:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abe3ea12e4a0d56dffff28c2e47c7b07fa1e74c6429535aa57ada08c9c1c3da35893aeb6c12e1a0a3bed224982f27321b9ceb1f4b69b3a8235a4f80c5b94efff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c7efe57560281ba78396e2b9c3ae665178e7523723abe0cb47c47090480c77e5d7d4b6fffb0485b5fe88669c095e62959aa94ea256041989db557204a53eaf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccb910e96b3d17e73a4ce30f31aa3498500908a80fdea3ce9c0a00a2ae6584e562103049aad66b17e4d59dc16398dd31f641147d6c259250d57a9bceb17d22d9"} 23:43:13 INFO - Running post-run listener: copy_logs_to_upload_dir 23:43:13 INFO - Copying logs to upload dir... 23:43:13 INFO - mkdir: /builds/slave/test/build/upload/logs 23:43:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.917599 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-13 23:43:12.223728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:12.226979) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abe3ea12e4a0d56dffff28c2e47c7b07fa1e74c6429535aa57ada08c9c1c3da35893aeb6c12e1a0a3bed224982f27321b9ceb1f4b69b3a8235a4f80c5b94efff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c7efe57560281ba78396e2b9c3ae665178e7523723abe0cb47c47090480c77e5d7d4b6fffb0485b5fe88669c095e62959aa94ea256041989db557204a53eaf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccb910e96b3d17e73a4ce30f31aa3498500908a80fdea3ce9c0a00a2ae6584e562103049aad66b17e4d59dc16398dd31f641147d6c259250d57a9bceb17d22d9"} build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abe3ea12e4a0d56dffff28c2e47c7b07fa1e74c6429535aa57ada08c9c1c3da35893aeb6c12e1a0a3bed224982f27321b9ceb1f4b69b3a8235a4f80c5b94efff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c7efe57560281ba78396e2b9c3ae665178e7523723abe0cb47c47090480c77e5d7d4b6fffb0485b5fe88669c095e62959aa94ea256041989db557204a53eaf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccb910e96b3d17e73a4ce30f31aa3498500908a80fdea3ce9c0a00a2ae6584e562103049aad66b17e4d59dc16398dd31f641147d6c259250d57a9bceb17d22d9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:12.252044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:12.252398) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468477361.249096-10581085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004747 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:12.334919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:43:12.335258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:43:12.335594) ========= ========= Total master_lag: 0.16 =========