builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1466642665.49 results: success (0) buildid: 20160622150924 builduid: afd162a89b93436cbed00d869a849370 revision: 364d6e860e97081c90de5f141d4a034ee4ddd073 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.489439) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.490367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.490731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.534998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.535361) ========= 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=0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 17:44:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.8M=0.001s 2016-06-22 17:44:26 (22.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088596 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.647341) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.647827) ========= 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=0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019328 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.705273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.705910) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 364d6e860e97081c90de5f141d4a034ee4ddd073 --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 364d6e860e97081c90de5f141d4a034ee4ddd073 --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=0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 17:44:26,283 truncating revision to first 12 chars 2016-06-22 17:44:26,283 Setting DEBUG logging. 2016-06-22 17:44:26,283 attempt 1/10 2016-06-22 17:44:26,283 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/364d6e860e97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 17:44:26,621 unpacking tar archive at: mozilla-aurora-364d6e860e97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:26.399198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:26.399546) ========= script_repo_revision: 364d6e860e97081c90de5f141d4a034ee4ddd073 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:26.400086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:26.400410) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:26.413238) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-22 17:44:26.413547) ========= /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=0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:44:27 INFO - MultiFileLogger online at 20160622 17:44:27 in /builds/slave/test 17:44:27 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 17:44:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:44:27 INFO - {'append_to_log': False, 17:44:27 INFO - 'base_work_dir': '/builds/slave/test', 17:44:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:44:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:44:27 INFO - 'branch': 'Mozilla-Aurora', 17:44:27 INFO - 'buildbot_json_path': 'buildprops.json', 17:44:27 INFO - 'config_files': ('talos/linux_config.py',), 17:44:27 INFO - 'default_actions': ('clobber', 17:44:27 INFO - 'read-buildbot-config', 17:44:27 INFO - 'download-and-extract', 17:44:27 INFO - 'populate-webroot', 17:44:27 INFO - 'create-virtualenv', 17:44:27 INFO - 'install', 17:44:27 INFO - 'run-tests'), 17:44:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:44:27 INFO - 'download_minidump_stackwalk': True, 17:44:27 INFO - 'download_symbols': 'ondemand', 17:44:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:44:27 INFO - 'tooltool.py': '/tools/tooltool.py', 17:44:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:44:27 INFO - '/tools/misc-python/virtualenv.py')}, 17:44:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:44:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:44:27 INFO - 'installer_path': 'installer.exe', 17:44:27 INFO - 'log_level': 'info', 17:44:27 INFO - 'log_name': 'talos', 17:44:27 INFO - 'log_to_console': True, 17:44:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:44:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:44:27 INFO - 'opt_config_files': (), 17:44:27 INFO - 'pip_index': False, 17:44:27 INFO - 'sps_profile': False, 17:44:27 INFO - 'sps_profile_interval': 0, 17:44:27 INFO - 'suite': 'dromaeojs-e10s', 17:44:27 INFO - 'system_bits': '32', 17:44:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:44:27 INFO - 'title': 'talos-linux64-ix-017', 17:44:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:44:27 INFO - 'use_talos_json': True, 17:44:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:44:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:44:27 INFO - 'work_dir': 'build'} 17:44:27 INFO - ##### 17:44:27 INFO - ##### Running clobber step. 17:44:27 INFO - ##### 17:44:27 INFO - Running pre-action listener: _resource_record_pre_action 17:44:27 INFO - Running main action method: clobber 17:44:27 INFO - rmtree: /builds/slave/test/build 17:44:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:44:28 INFO - Running post-action listener: _resource_record_post_action 17:44:28 INFO - ##### 17:44:28 INFO - ##### Finished clobber step (success) 17:44:28 INFO - ##### 17:44:28 INFO - ##### 17:44:28 INFO - ##### Running read-buildbot-config step. 17:44:28 INFO - ##### 17:44:28 INFO - Running pre-action listener: _resource_record_pre_action 17:44:28 INFO - Running main action method: read_buildbot_config 17:44:28 INFO - Using buildbot properties: 17:44:28 INFO - { 17:44:28 INFO - "project": "", 17:44:28 INFO - "product": "firefox", 17:44:28 INFO - "script_repo_revision": "production", 17:44:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 17:44:28 INFO - "repository": "", 17:44:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 17:44:28 INFO - "buildid": "20160622150924", 17:44:28 INFO - "pgo_build": "True", 17:44:28 INFO - "basedir": "/builds/slave/test", 17:44:28 INFO - "buildnumber": 363, 17:44:28 INFO - "slavename": "talos-linux64-ix-017", 17:44:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:44:28 INFO - "platform": "ubuntu64_hw", 17:44:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:44:28 INFO - "branch": "mozilla-aurora", 17:44:28 INFO - "repo_path": "releases/mozilla-aurora", 17:44:28 INFO - "revision": "364d6e860e97081c90de5f141d4a034ee4ddd073", 17:44:28 INFO - "stage_platform": "linux64-pgo", 17:44:28 INFO - "builduid": "afd162a89b93436cbed00d869a849370", 17:44:28 INFO - "slavebuilddir": "test" 17:44:28 INFO - } 17:44:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 17:44:28 INFO - Running post-action listener: _resource_record_post_action 17:44:28 INFO - ##### 17:44:28 INFO - ##### Finished read-buildbot-config step (success) 17:44:28 INFO - ##### 17:44:28 INFO - ##### 17:44:28 INFO - ##### Running download-and-extract step. 17:44:28 INFO - ##### 17:44:28 INFO - Running pre-action listener: _resource_record_pre_action 17:44:28 INFO - Running main action method: download_and_extract 17:44:28 INFO - mkdir: /builds/slave/test/build/tests 17:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:28 INFO - https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/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 17:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/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 17:44:28 INFO - Downloaded 1361 bytes. 17:44:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:44:28 INFO - Using the following test package requirements: 17:44:28 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:44:28 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:44:28 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:44:28 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:28 INFO - u'jsshell-linux-x86_64.zip'], 17:44:28 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:44:28 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:44:28 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:44:28 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:44:28 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:44:28 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:44:28 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:28 INFO - https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:44:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:44:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:44:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/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 17:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/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 17:44:48 INFO - Downloaded 24474376 bytes. 17:44:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:44:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:44:49 INFO - Return code: 0 17:44:49 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 17:44: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')]} 17:44:49 INFO - https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/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 17:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/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 17:44:51 INFO - Downloaded 24474376 bytes. 17:44:51 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'] 17:44:51 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 17:44:52 INFO - Return code: 0 17:44:52 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')]} 17:44:52 INFO - https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:44:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:44:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:44:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/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 17:44:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/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 17:44:53 INFO - Downloaded 10833369 bytes. 17:44:53 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'] 17:44:53 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 17:44:53 INFO - Return code: 0 17:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:53 INFO - https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:44:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:44:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:44:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/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 17:44:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/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 17:44:55 INFO - Downloaded 63604861 bytes. 17:44:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:44:55 INFO - mkdir: /builds/slave/test/properties 17:44:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:44:55 INFO - Writing to file /builds/slave/test/properties/build_url 17:44:55 INFO - Contents: 17:44:55 INFO - build_url:https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:44:56 INFO - Running post-action listener: _resource_record_post_action 17:44:56 INFO - Running post-action listener: set_extra_try_arguments 17:44:56 INFO - ##### 17:44:56 INFO - ##### Finished download-and-extract step (success) 17:44:56 INFO - ##### 17:44:56 INFO - ##### 17:44:56 INFO - ##### Running populate-webroot step. 17:44:56 INFO - ##### 17:44:56 INFO - Running pre-action listener: _resource_record_pre_action 17:44:56 INFO - Running main action method: populate_webroot 17:44:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:44:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:44:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:44:56 INFO - '--tppagecycles', 17:44:56 INFO - '7'], 17:44:56 INFO - 'tests': ['tsvgm']}}, 17:44:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:44:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:44:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:44:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:44:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:44:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:44:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:56 INFO - 'talos_options': ['--disable-e10s'], 17:44:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:56 INFO - 'talos_options': ['--disable-e10s'], 17:44:56 INFO - 'tests': ['damp', 'tps']}, 17:44:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:56 INFO - 'tests': ['damp', 'tps']}, 17:44:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:44:56 INFO - 'tests': ['dromaeo_dom']}, 17:44:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:44:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:44:56 INFO - 'tests': ['a11yr', 17:44:56 INFO - 'ts_paint', 17:44:56 INFO - 'tpaint', 17:44:56 INFO - 'sessionrestore', 17:44:56 INFO - 'sessionrestore_no_auto_restore', 17:44:56 INFO - 'tabpaint']}, 17:44:56 INFO - 'other-e10s': {'tests': ['a11yr', 17:44:56 INFO - 'ts_paint', 17:44:56 INFO - 'tpaint', 17:44:56 INFO - 'sessionrestore', 17:44:56 INFO - 'sessionrestore_no_auto_restore', 17:44:56 INFO - 'tabpaint']}, 17:44:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:44:56 INFO - 'ts_paint', 17:44:56 INFO - 'tpaint', 17:44:56 INFO - 'sessionrestore', 17:44:56 INFO - 'sessionrestore_no_auto_restore', 17:44:56 INFO - 'tabpaint']}, 17:44:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:44:56 INFO - 'ts_paint', 17:44:56 INFO - 'tpaint', 17:44:56 INFO - 'sessionrestore', 17:44:56 INFO - 'sessionrestore_no_auto_restore', 17:44:56 INFO - 'tabpaint']}, 17:44:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:44:56 INFO - 'tests': ['a11yr', 17:44:56 INFO - 'ts_paint', 17:44:56 INFO - 'tpaint', 17:44:56 INFO - 'sessionrestore', 17:44:56 INFO - 'sessionrestore_no_auto_restore', 17:44:56 INFO - 'tabpaint']}, 17:44:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:44:56 INFO - 'tests': ['a11yr', 17:44:56 INFO - 'ts_paint', 17:44:56 INFO - 'tpaint', 17:44:56 INFO - 'sessionrestore', 17:44:56 INFO - 'sessionrestore_no_auto_restore', 17:44:56 INFO - 'tabpaint']}, 17:44:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:44:56 INFO - 'tests': ['tsvgx', 17:44:56 INFO - 'tsvgr_opacity', 17:44:56 INFO - 'tart', 17:44:56 INFO - 'tscrollx', 17:44:56 INFO - 'cart']}, 17:44:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:44:56 INFO - 'tsvgr_opacity', 17:44:56 INFO - 'tart', 17:44:56 INFO - 'tscrollx', 17:44:56 INFO - 'cart']}, 17:44:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:56 INFO - 'talos_options': ['--disable-e10s'], 17:44:56 INFO - 'tests': ['tp5o']}, 17:44:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:56 INFO - 'tests': ['tp5o']}, 17:44:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:56 INFO - 'talos_options': ['--disable-e10s', 17:44:56 INFO - '--xperf_path', 17:44:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:56 INFO - 'tests': ['tp5n']}, 17:44:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:56 INFO - 'talos_options': ['--xperf_path', 17:44:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:56 INFO - 'tests': ['tp5n']}}, 17:44:56 INFO - 'talos.zip': {'path': '', 17:44:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:44:56 INFO - Running post-action listener: _resource_record_post_action 17:44:56 INFO - ##### 17:44:56 INFO - ##### Finished populate-webroot step (success) 17:44:56 INFO - ##### 17:44:56 INFO - ##### 17:44:56 INFO - ##### Running create-virtualenv step. 17:44:56 INFO - ##### 17:44:56 INFO - Running pre-action listener: _resource_record_pre_action 17:44:56 INFO - Running main action method: create_virtualenv 17:44:56 INFO - Creating virtualenv /builds/slave/test/build/venv 17:44:56 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 17:44:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:44:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:44:56 INFO - Using real prefix '/usr' 17:44:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:44:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:44:59 INFO - Installing pip.................done. 17:44:59 INFO - Return code: 0 17:44:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:44:59 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')]} 17:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:59 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')]} 17:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:59 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 0x7f53ba709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, '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': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', '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 17:44:59 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 17:44:59 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 17:44:59 INFO - Using env: {'DISPLAY': ':0', 17:44:59 INFO - 'HOME': '/home/cltbld', 17:44:59 INFO - 'LANG': 'en_US.UTF-8', 17:44:59 INFO - 'LANGUAGE': 'en_US:en', 17:44:59 INFO - 'LOGNAME': 'cltbld', 17:44:59 INFO - 'MAIL': '/var/mail/cltbld', 17:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:59 INFO - 'MOZ_NO_REMOTE': '1', 17:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:59 INFO - 'NO_EM_RESTART': '1', 17:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:59 INFO - 'PWD': '/builds/slave/test', 17:44:59 INFO - 'SHELL': '/bin/bash', 17:44:59 INFO - 'SHLVL': '1', 17:44:59 INFO - 'TERM': 'linux', 17:44:59 INFO - 'TMOUT': '86400', 17:44:59 INFO - 'USER': 'cltbld', 17:44:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:59 INFO - '_': '/tools/buildbot/bin/python'} 17:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:59 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 17:44:59 INFO - Cleaning up... 17:44:59 INFO - Return code: 0 17:44:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:44:59 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')]} 17:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:59 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')]} 17:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:59 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 0x7f53ba709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, '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': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', '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 17:44:59 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 17:44:59 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 17:44:59 INFO - Using env: {'DISPLAY': ':0', 17:44:59 INFO - 'HOME': '/home/cltbld', 17:44:59 INFO - 'LANG': 'en_US.UTF-8', 17:44:59 INFO - 'LANGUAGE': 'en_US:en', 17:44:59 INFO - 'LOGNAME': 'cltbld', 17:44:59 INFO - 'MAIL': '/var/mail/cltbld', 17:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:59 INFO - 'MOZ_NO_REMOTE': '1', 17:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:59 INFO - 'NO_EM_RESTART': '1', 17:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:59 INFO - 'PWD': '/builds/slave/test', 17:44:59 INFO - 'SHELL': '/bin/bash', 17:44:59 INFO - 'SHLVL': '1', 17:44:59 INFO - 'TERM': 'linux', 17:44:59 INFO - 'TMOUT': '86400', 17:44:59 INFO - 'USER': 'cltbld', 17:44:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:59 INFO - '_': '/tools/buildbot/bin/python'} 17:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:59 INFO - Downloading/unpacking psutil>=3.1.1 17:44:59 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 17:44:59 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 17:44:59 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 17:44:59 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 17:44:59 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 17:44:59 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 17:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:01 INFO - Installing collected packages: psutil 17:45:01 INFO - Running setup.py install for psutil 17:45:01 INFO - building 'psutil._psutil_linux' extension 17:45:01 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 17:45:02 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 17:45:02 INFO - building 'psutil._psutil_posix' extension 17:45:02 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 17:45:02 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 17:45:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:02 INFO - Successfully installed psutil 17:45:02 INFO - Cleaning up... 17:45:02 INFO - Return code: 0 17:45:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:45:02 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')]} 17:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:02 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')]} 17:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:02 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 0x7f53ba709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, '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': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', '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 17:45:02 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 17:45:02 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 17:45:02 INFO - Using env: {'DISPLAY': ':0', 17:45:02 INFO - 'HOME': '/home/cltbld', 17:45:02 INFO - 'LANG': 'en_US.UTF-8', 17:45:02 INFO - 'LANGUAGE': 'en_US:en', 17:45:02 INFO - 'LOGNAME': 'cltbld', 17:45:02 INFO - 'MAIL': '/var/mail/cltbld', 17:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:02 INFO - 'MOZ_NO_REMOTE': '1', 17:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:02 INFO - 'NO_EM_RESTART': '1', 17:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:02 INFO - 'PWD': '/builds/slave/test', 17:45:02 INFO - 'SHELL': '/bin/bash', 17:45:02 INFO - 'SHLVL': '1', 17:45:02 INFO - 'TERM': 'linux', 17:45:02 INFO - 'TMOUT': '86400', 17:45:02 INFO - 'USER': 'cltbld', 17:45:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:02 INFO - '_': '/tools/buildbot/bin/python'} 17:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:45: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 17:45: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 17:45: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 17:45: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 17:45: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 17:45: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 17:45:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:45:04 INFO - Installing collected packages: mozsystemmonitor 17:45:04 INFO - Running setup.py install for mozsystemmonitor 17:45:04 INFO - Successfully installed mozsystemmonitor 17:45:04 INFO - Cleaning up... 17:45:04 INFO - Return code: 0 17:45:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:45:04 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')]} 17:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:04 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')]} 17:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:04 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 0x7f53ba709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, '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': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', '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 17:45:04 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 17:45:04 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 17:45:04 INFO - Using env: {'DISPLAY': ':0', 17:45:04 INFO - 'HOME': '/home/cltbld', 17:45:04 INFO - 'LANG': 'en_US.UTF-8', 17:45:04 INFO - 'LANGUAGE': 'en_US:en', 17:45:04 INFO - 'LOGNAME': 'cltbld', 17:45:04 INFO - 'MAIL': '/var/mail/cltbld', 17:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:04 INFO - 'MOZ_NO_REMOTE': '1', 17:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:04 INFO - 'NO_EM_RESTART': '1', 17:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:04 INFO - 'PWD': '/builds/slave/test', 17:45:04 INFO - 'SHELL': '/bin/bash', 17:45:04 INFO - 'SHLVL': '1', 17:45:04 INFO - 'TERM': 'linux', 17:45:04 INFO - 'TMOUT': '86400', 17:45:04 INFO - 'USER': 'cltbld', 17:45:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:04 INFO - '_': '/tools/buildbot/bin/python'} 17:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:04 INFO - Downloading/unpacking jsonschema==2.5.1 17:45:04 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 17:45:04 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 17:45:04 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 17:45:04 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 17:45:04 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 17:45:04 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 17:45:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:45:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:06 INFO - Downloading functools32-3.2.3-2.tar.gz 17:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:45:07 INFO - warning: no files found matching '*.txt' 17:45:07 INFO - no previously-included directories found matching 'build' 17:45:07 INFO - no previously-included directories found matching 'dist' 17:45:07 INFO - no previously-included directories found matching '.git*' 17:45:07 INFO - Installing collected packages: jsonschema, functools32 17:45:07 INFO - Running setup.py install for functools32 17:45:07 INFO - warning: no files found matching '*.txt' 17:45:07 INFO - no previously-included directories found matching 'build' 17:45:07 INFO - no previously-included directories found matching 'dist' 17:45:07 INFO - no previously-included directories found matching '.git*' 17:45:07 INFO - Successfully installed jsonschema functools32 17:45:07 INFO - Cleaning up... 17:45:07 INFO - Return code: 0 17:45:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53ba709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, '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': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', '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 17:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:45:07 INFO - Using env: {'DISPLAY': ':0', 17:45:07 INFO - 'HOME': '/home/cltbld', 17:45:07 INFO - 'LANG': 'en_US.UTF-8', 17:45:07 INFO - 'LANGUAGE': 'en_US:en', 17:45:07 INFO - 'LOGNAME': 'cltbld', 17:45:07 INFO - 'MAIL': '/var/mail/cltbld', 17:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:07 INFO - 'MOZ_NO_REMOTE': '1', 17:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:07 INFO - 'NO_EM_RESTART': '1', 17:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:07 INFO - 'PWD': '/builds/slave/test', 17:45:07 INFO - 'SHELL': '/bin/bash', 17:45:07 INFO - 'SHLVL': '1', 17:45:07 INFO - 'TERM': 'linux', 17:45:07 INFO - 'TMOUT': '86400', 17:45:07 INFO - 'USER': 'cltbld', 17:45:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:07 INFO - '_': '/tools/buildbot/bin/python'} 17:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:45:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:45:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:10 INFO - Downloading docopt-0.6.1.tar.gz 17:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:45:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:45:10 INFO - Running setup.py install for blobuploader 17:45:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:45:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:45:10 INFO - Running setup.py install for requests 17:45:10 INFO - Running setup.py install for docopt 17:45:10 INFO - Successfully installed blobuploader requests docopt 17:45:10 INFO - Cleaning up... 17:45:10 INFO - Return code: 0 17:45:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45: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')]} 17:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45: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')]} 17:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53ba709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, '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': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', '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 17:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:45:10 INFO - Using env: {'DISPLAY': ':0', 17:45:10 INFO - 'HOME': '/home/cltbld', 17:45:10 INFO - 'LANG': 'en_US.UTF-8', 17:45:10 INFO - 'LANGUAGE': 'en_US:en', 17:45:10 INFO - 'LOGNAME': 'cltbld', 17:45:10 INFO - 'MAIL': '/var/mail/cltbld', 17:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:10 INFO - 'MOZ_NO_REMOTE': '1', 17:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:10 INFO - 'NO_EM_RESTART': '1', 17:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:10 INFO - 'PWD': '/builds/slave/test', 17:45:10 INFO - 'SHELL': '/bin/bash', 17:45:10 INFO - 'SHLVL': '1', 17:45:10 INFO - 'TERM': 'linux', 17:45:10 INFO - 'TMOUT': '86400', 17:45:10 INFO - 'USER': 'cltbld', 17:45:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:10 INFO - '_': '/tools/buildbot/bin/python'} 17:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:45:10 INFO - Running setup.py (path:/tmp/pip-5Q3hPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:45:10 INFO - Running setup.py (path:/tmp/pip-VoZ0Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:45:11 INFO - Running setup.py (path:/tmp/pip-rBA4Af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:45:11 INFO - Running setup.py (path:/tmp/pip-cmYD9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:45:11 INFO - Running setup.py (path:/tmp/pip-6dzara-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:45:11 INFO - Running setup.py (path:/tmp/pip-ypqVCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:45:11 INFO - Running setup.py (path:/tmp/pip-oFCbsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:45:11 INFO - Running setup.py (path:/tmp/pip-ivFWXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:45:11 INFO - Running setup.py (path:/tmp/pip-6lniTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:45:11 INFO - Running setup.py (path:/tmp/pip-dd81e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:45:11 INFO - Running setup.py (path:/tmp/pip-YMRocZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:45:11 INFO - Running setup.py (path:/tmp/pip-VSMzHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:45:11 INFO - Running setup.py (path:/tmp/pip-w1QdGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:45:11 INFO - Running setup.py (path:/tmp/pip-UsboF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:11 INFO - Running setup.py (path:/tmp/pip-vuF4Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:45:12 INFO - Running setup.py (path:/tmp/pip-19cJdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:45:12 INFO - Running setup.py (path:/tmp/pip-jKO2eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:45:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:45:12 INFO - Running setup.py install for manifestparser 17:45:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Running setup.py install for mozcrash 17:45:12 INFO - Running setup.py install for mozdebug 17:45:12 INFO - Running setup.py install for mozdevice 17:45:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Running setup.py install for mozfile 17:45:12 INFO - Running setup.py install for mozhttpd 17:45:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Running setup.py install for mozinfo 17:45:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Running setup.py install for mozInstall 17:45:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Running setup.py install for mozleak 17:45:13 INFO - Running setup.py install for mozlog 17:45:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:45:13 INFO - Running setup.py install for moznetwork 17:45:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:45:13 INFO - Running setup.py install for mozprocess 17:45:13 INFO - Running setup.py install for mozprofile 17:45:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:45:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:45:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:45:13 INFO - Running setup.py install for mozrunner 17:45:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:45:13 INFO - Running setup.py install for mozscreenshot 17:45:13 INFO - Running setup.py install for moztest 17:45:13 INFO - Running setup.py install for mozversion 17:45:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:45:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:45:13 INFO - Cleaning up... 17:45:13 INFO - Return code: 0 17:45:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45: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')]} 17:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45: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')]} 17:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53ba709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, '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': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', '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 17:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:45:13 INFO - Using env: {'DISPLAY': ':0', 17:45:13 INFO - 'HOME': '/home/cltbld', 17:45:13 INFO - 'LANG': 'en_US.UTF-8', 17:45:13 INFO - 'LANGUAGE': 'en_US:en', 17:45:13 INFO - 'LOGNAME': 'cltbld', 17:45:13 INFO - 'MAIL': '/var/mail/cltbld', 17:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:13 INFO - 'MOZ_NO_REMOTE': '1', 17:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:13 INFO - 'NO_EM_RESTART': '1', 17:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:13 INFO - 'PWD': '/builds/slave/test', 17:45:13 INFO - 'SHELL': '/bin/bash', 17:45:13 INFO - 'SHLVL': '1', 17:45:13 INFO - 'TERM': 'linux', 17:45:13 INFO - 'TMOUT': '86400', 17:45:13 INFO - 'USER': 'cltbld', 17:45:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:13 INFO - '_': '/tools/buildbot/bin/python'} 17:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:45:14 INFO - Running setup.py (path:/tmp/pip-3iH5jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:45:14 INFO - Running setup.py (path:/tmp/pip-KRUqEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:45:14 INFO - Running setup.py (path:/tmp/pip-yMlAvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:45:14 INFO - Running setup.py (path:/tmp/pip-tzYx7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:45:14 INFO - Running setup.py (path:/tmp/pip-KIGGxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:45:14 INFO - Running setup.py (path:/tmp/pip-pST3ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:45:14 INFO - Running setup.py (path:/tmp/pip-DTDBTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:45:14 INFO - Running setup.py (path:/tmp/pip-EPNfA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:45:14 INFO - Running setup.py (path:/tmp/pip-afASH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:45:14 INFO - Running setup.py (path:/tmp/pip-FT1zbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:45:14 INFO - Running setup.py (path:/tmp/pip-uYI8mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:45:14 INFO - Running setup.py (path:/tmp/pip-vS2jPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:45:15 INFO - Running setup.py (path:/tmp/pip-5y_34C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:45:15 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)) 17:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:45:15 INFO - Running setup.py (path:/tmp/pip-zwFYsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:15 INFO - Running setup.py (path:/tmp/pip-6VrfoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:45:15 INFO - Running setup.py (path:/tmp/pip-_Zhjpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:45:15 INFO - Running setup.py (path:/tmp/pip-k1lZew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:45:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:17 INFO - Downloading blessings-1.6.tar.gz 17:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:45:17 INFO - Installing collected packages: blessings 17:45:17 INFO - Running setup.py install for blessings 17:45:17 INFO - Successfully installed blessings 17:45:17 INFO - Cleaning up... 17:45:17 INFO - Return code: 0 17:45:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:45:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:45:17 INFO - Reading from file tmpfile_stdout 17:45:17 INFO - Current package versions: 17:45:17 INFO - argparse == 1.2.1 17:45:17 INFO - blessings == 1.6 17:45:17 INFO - blobuploader == 1.2.4 17:45:17 INFO - docopt == 0.6.1 17:45:17 INFO - functools32 == 3.2.3-2 17:45:17 INFO - jsonschema == 2.5.1 17:45:17 INFO - manifestparser == 1.1 17:45:17 INFO - mozInstall == 1.12 17:45:17 INFO - mozcrash == 0.17 17:45:17 INFO - mozdebug == 0.1 17:45:17 INFO - mozdevice == 0.48 17:45:17 INFO - mozfile == 1.2 17:45:17 INFO - mozhttpd == 0.7 17:45:17 INFO - mozinfo == 0.9 17:45:17 INFO - mozleak == 0.1 17:45:17 INFO - mozlog == 3.2 17:45:17 INFO - moznetwork == 0.27 17:45:17 INFO - mozprocess == 0.22 17:45:17 INFO - mozprofile == 0.28 17:45:17 INFO - mozrunner == 6.11 17:45:17 INFO - mozscreenshot == 0.1 17:45:17 INFO - mozsystemmonitor == 0.3 17:45:17 INFO - moztest == 0.7 17:45:17 INFO - mozversion == 1.4 17:45:17 INFO - psutil == 3.1.1 17:45:17 INFO - requests == 1.2.3 17:45:17 INFO - wsgiref == 0.1.2 17:45:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53ba709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, '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': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', '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 17:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:45:17 INFO - Using env: {'DISPLAY': ':0', 17:45:17 INFO - 'HOME': '/home/cltbld', 17:45:17 INFO - 'LANG': 'en_US.UTF-8', 17:45:17 INFO - 'LANGUAGE': 'en_US:en', 17:45:17 INFO - 'LOGNAME': 'cltbld', 17:45:17 INFO - 'MAIL': '/var/mail/cltbld', 17:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:17 INFO - 'MOZ_NO_REMOTE': '1', 17:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:17 INFO - 'NO_EM_RESTART': '1', 17:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:17 INFO - 'PWD': '/builds/slave/test', 17:45:17 INFO - 'SHELL': '/bin/bash', 17:45:17 INFO - 'SHLVL': '1', 17:45:17 INFO - 'TERM': 'linux', 17:45:17 INFO - 'TMOUT': '86400', 17:45:17 INFO - 'USER': 'cltbld', 17:45:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:17 INFO - '_': '/tools/buildbot/bin/python'} 17:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:45:17 INFO - Cleaning up... 17:45:17 INFO - Return code: 0 17:45:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53ba709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, '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': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', '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 17:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:45:17 INFO - Using env: {'DISPLAY': ':0', 17:45:17 INFO - 'HOME': '/home/cltbld', 17:45:17 INFO - 'LANG': 'en_US.UTF-8', 17:45:17 INFO - 'LANGUAGE': 'en_US:en', 17:45:18 INFO - 'LOGNAME': 'cltbld', 17:45:18 INFO - 'MAIL': '/var/mail/cltbld', 17:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:18 INFO - 'MOZ_NO_REMOTE': '1', 17:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:18 INFO - 'NO_EM_RESTART': '1', 17:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:18 INFO - 'PWD': '/builds/slave/test', 17:45:18 INFO - 'SHELL': '/bin/bash', 17:45:18 INFO - 'SHLVL': '1', 17:45:18 INFO - 'TERM': 'linux', 17:45:18 INFO - 'TMOUT': '86400', 17:45:18 INFO - 'USER': 'cltbld', 17:45:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:18 INFO - '_': '/tools/buildbot/bin/python'} 17:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:45:18 INFO - Cleaning up... 17:45:18 INFO - Return code: 0 17:45:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53ba709f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, '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': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', '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 17:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:45:18 INFO - Using env: {'DISPLAY': ':0', 17:45:18 INFO - 'HOME': '/home/cltbld', 17:45:18 INFO - 'LANG': 'en_US.UTF-8', 17:45:18 INFO - 'LANGUAGE': 'en_US:en', 17:45:18 INFO - 'LOGNAME': 'cltbld', 17:45:18 INFO - 'MAIL': '/var/mail/cltbld', 17:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:18 INFO - 'MOZ_NO_REMOTE': '1', 17:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:18 INFO - 'NO_EM_RESTART': '1', 17:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:18 INFO - 'PWD': '/builds/slave/test', 17:45:18 INFO - 'SHELL': '/bin/bash', 17:45:18 INFO - 'SHLVL': '1', 17:45:18 INFO - 'TERM': 'linux', 17:45:18 INFO - 'TMOUT': '86400', 17:45:18 INFO - 'USER': 'cltbld', 17:45:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:18 INFO - '_': '/tools/buildbot/bin/python'} 17:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:18 INFO - Downloading/unpacking flake8 17:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:45:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:45:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:45:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:45:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:45:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:45:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:45:21 INFO - no previously-included directories found matching 'docs/_build' 17:45:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:45:21 INFO - Running setup.py install for pep8 17:45:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:45:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:45:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:45:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:45:21 INFO - no previously-included directories found matching 'docs/_build' 17:45:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:45:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:45:21 INFO - Cleaning up... 17:45:21 INFO - Return code: 0 17:45:21 INFO - Running post-action listener: _resource_record_post_action 17:45:21 INFO - Running post-action listener: _start_resource_monitoring 17:45:21 INFO - Starting resource monitoring. 17:45:21 INFO - ##### 17:45:21 INFO - ##### Finished create-virtualenv step (success) 17:45:21 INFO - ##### 17:45:21 INFO - ##### 17:45:21 INFO - ##### Running install step. 17:45:21 INFO - ##### 17:45:21 INFO - Running pre-action listener: _resource_record_pre_action 17:45:21 INFO - Running main action method: install 17:45:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:45:21 INFO - Reading from file tmpfile_stdout 17:45:21 INFO - Detecting whether we're running mozinstall >=1.0... 17:45:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:45:21 INFO - Reading from file tmpfile_stdout 17:45:21 INFO - Output received: 17:45:21 INFO - Usage: mozinstall [options] installer 17:45:21 INFO - Options: 17:45:21 INFO - -h, --help show this help message and exit 17:45:21 INFO - -d DEST, --destination=DEST 17:45:21 INFO - Directory to install application into. [default: 17:45:21 INFO - "/builds/slave/test"] 17:45:21 INFO - --app=APP Application being installed. [default: firefox] 17:45:21 INFO - mkdir: /builds/slave/test/build/application 17:45:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:45:37 INFO - Reading from file tmpfile_stdout 17:45:37 INFO - Output received: 17:45:37 INFO - /builds/slave/test/build/application/firefox/firefox 17:45:37 INFO - Running post-action listener: _resource_record_post_action 17:45:37 INFO - ##### 17:45:37 INFO - ##### Finished install step (success) 17:45:37 INFO - ##### 17:45:37 INFO - ##### 17:45:37 INFO - ##### Running run-tests step. 17:45:37 INFO - ##### 17:45:37 INFO - Running pre-action listener: _resource_record_pre_action 17:45:37 INFO - Running main action method: run_tests 17:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:45:37 INFO - Python 2.7.3 17:45:37 INFO - Return code: 0 17:45:37 INFO - grabbing minidump binary from tooltool 17:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e02e0>, '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 0x274c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:45:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:45:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:45:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:45:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:45:37 INFO - Return code: 0 17:45:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:45:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:45:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:45:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:45:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:45:38 INFO - Return code: 0 17:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 17:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 17:45:38 INFO - Using env: {'DISPLAY': ':0', 17:45:38 INFO - 'HOME': '/home/cltbld', 17:45:38 INFO - 'LANG': 'en_US.UTF-8', 17:45:38 INFO - 'LANGUAGE': 'en_US:en', 17:45:38 INFO - 'LOGNAME': 'cltbld', 17:45:38 INFO - 'MAIL': '/var/mail/cltbld', 17:45:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:45:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:38 INFO - 'MOZ_NO_REMOTE': '1', 17:45:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:38 INFO - 'NO_EM_RESTART': '1', 17:45:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:38 INFO - 'PWD': '/builds/slave/test', 17:45:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:45:38 INFO - 'SHELL': '/bin/bash', 17:45:38 INFO - 'SHLVL': '1', 17:45:38 INFO - 'TERM': 'linux', 17:45:38 INFO - 'TMOUT': '86400', 17:45:38 INFO - 'USER': 'cltbld', 17:45:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143', 17:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:38 INFO - '_': '/tools/buildbot/bin/python'} 17:45:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 17:45:38 INFO - mozversion application_buildid: 20160622150924 17:45:38 INFO - mozversion application_changeset: 364d6e860e97081c90de5f141d4a034ee4ddd073 17:45:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:45:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:45:38 INFO - mozversion application_name: Firefox 17:45:38 INFO - mozversion application_remotingname: firefox-dev 17:45:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:45:38 INFO - mozversion application_vendor: Mozilla 17:45:38 INFO - mozversion application_version: 49.0a2 17:45:38 INFO - mozversion platform_buildid: 20160622150924 17:45:38 INFO - mozversion platform_changeset: 364d6e860e97081c90de5f141d4a034ee4ddd073 17:45:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:45:38 INFO - mozversion platform_version: 49.0a2 17:45:38 INFO - using testdate: 1466642738 17:45:38 INFO - actual date: 1466642738 17:45:38 INFO - starting webserver on 'localhost:59435' 17:45:38 INFO - SUITE-START | Running 2 tests 17:45:38 INFO - TEST-START | dromaeo_css 17:45:38 INFO - operating with platform_type : linux_ 17:45:38 INFO - Initialising browser for dromaeo_css test... 17:45:38 INFO - TEST-INFO | started process 7038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6hta8/profile http://localhost:59435/getInfo.html) 17:45:42 INFO - PROCESS | 7038 | __metrics Screen width/height:1600/1200 17:45:42 INFO - PROCESS | 7038 | colorDepth:24 17:45:42 INFO - PROCESS | 7038 | Browser inner width/height: 1024/697 17:45:42 INFO - PROCESS | 7038 | __metrics 17:45:43 ERROR - PROCESS | 7038 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 17:45:44 INFO - TEST-INFO | 7038: exit 0 17:45:44 INFO - Browser initialized. 17:45:44 INFO - Running cycle 1/1 for dromaeo_css test... 17:45:44 INFO - TEST-INFO | started process 7167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6hta8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:56 INFO - PROCESS | 7167 | RSS: Main: 156172288 17:45:56 INFO - PROCESS | 7167 | 17:46:45 INFO - PROCESS | 7167 | 1466642805604 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] 17:48:53 INFO - PROCESS | 7167 | Cycle 1(1): loaded http://localhost:59435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59435/tests/dromaeo/cssquery-ext.html) 17:48:54 INFO - PROCESS | 7167 | RSS: Main: 159830016 17:48:54 INFO - PROCESS | 7167 | 17:51:56 INFO - PROCESS | 7167 | Cycle 1(1): loaded http://localhost:59435/tests/dromaeo/cssquery-ext.html (next: http://localhost:59435/tests/dromaeo/cssquery-jquery.html) 17:51:57 INFO - PROCESS | 7167 | RSS: Main: 157958144 17:51:57 INFO - PROCESS | 7167 | 17:54:58 INFO - PROCESS | 7167 | Cycle 1(1): loaded http://localhost:59435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59435/tests/dromaeo/cssquery-mootools.html) 17:54:59 INFO - PROCESS | 7167 | RSS: Main: 156778496 17:54:59 INFO - PROCESS | 7167 | 17:58:01 INFO - PROCESS | 7167 | Cycle 1(1): loaded http://localhost:59435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59435/tests/dromaeo/cssquery-prototype.html) 17:58:01 INFO - PROCESS | 7167 | RSS: Main: 156512256 17:58:01 INFO - PROCESS | 7167 | 18:01:04 INFO - PROCESS | 7167 | Cycle 1(1): loaded http://localhost:59435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59435/tests/dromaeo/cssquery-yui.html) 18:01:04 INFO - PROCESS | 7167 | RSS: Main: 158519296 18:01:04 INFO - PROCESS | 7167 | 18:04:07 INFO - PROCESS | 7167 | Cycle 1(1): loaded http://localhost:59435/tests/dromaeo/cssquery-yui.html (next: http://localhost:59435/tests/dromaeo/cssquery-dojo.html) 18:04:07 INFO - PROCESS | 7167 | RSS: Main: 159121408 18:04:07 INFO - PROCESS | 7167 | 18:04:07 INFO - PROCESS | 7167 | __start_tp_report 18:04:07 INFO - PROCESS | 7167 | _x_x_mozilla_page_load 18:04:07 INFO - PROCESS | 7167 | _x_x_mozilla_page_load_details 18:04:07 INFO - PROCESS | 7167 | |i|pagename|runs| 18:04:07 INFO - PROCESS | 7167 | |0;dojo.html;3347.481140423234;3363.5627368442097;3370.9325813483715;3377.138829598453;3389.7796643218203;5508.421615730351;5530.723463826807;5552.916706249404;5576.414476479972;5602.85992850179;5538.47384498473;5613.887722245553;5628.240187574676;5631.042722737135;5649.23735295735;5045.1423258046125;5084.542391184793;5143.560336194746;5152.768125434364;5169.715665638407;5032.496750324956;5033.899322013557;5078.365204349457;5171.586273098162;5183.377994640629;5072.4673909239555;5115.923261151086;5129.461406552315;5136.8715782105555;5155.355580552431;5127.9743601282125;5171.276021357013;5181.481851814826;5207.713575753332;5239.711815850127;4920.729359885205;5104.259882317043;5116.8998665287145;5161.690298582097;5182.559482443997;5443.537299329561;5496.862578435531;5514.834554963358;5517;5547.195656629807;6070.908936365958;6101.633901965896;6117.785877494311;6119.082137679339;6124.11200375943;5932.9703351483395;6074.301455332649;6144.631322120687;6167.722452489604;6183.6598987055695;5705.914411283834;5755.856103597402;5769.798057068025;5777.740001699892;5787.479126878601;6244.656543890039;6251.4061164189325;6255.812325630239;6273.059041143773;6275.843103922347;5769.826905192851;5896.233489646404;5902.144189092557;6023.0062039763825;6031.004884194146;6049.032154855202;6049.969750151309;6053.182820319201;6089.086637004396;6097.756089756449;5949.1076338549565;6063.060225665029;6065.423784740443;6075.635461872302;6091.360407157274;5819.243498345188;5981.730822113015;6000.909986350208;6043.244594425697;6059.666718330446;4643.44278686553;4644.790984405709;4649.95350046502;4656.348111264426;4693.48371679115;4174.478190226222;4180.979095104566;4196.265653510623;4207.0954744729415;4212.262854000538;5645.1532270159805;5840.2991641003355;5862.618929769551;5876;5941.1088336749835;6015.368386319461;6025.728842202111;6082.2701275847185;6118.296395914438;6141.631502109888;5740.913886291709;5884.440978107073;5885.61743486672;5908;5908;5184.533391994739;5192.8961420771375;5205;5228.398734145546;5289.338832645919;6295.150154729053;6305.684715764193;6322.083297921868;6333.809985700436;6337.588056776387;5935.139404786368;6081.209442772411;6086.878262434815;6089.147519347383;6096.116063170904;6263.62418254888;6304.085907543289;6307.117003619589;6391.456726178327;6395.392437718409;5970.76116955317;6016.518678505797;6019.006863867413;6024.8795024100145;6040.426159514839;5924.555658325729;6022.066579680157;6112.365824595983;6117.113018612187;6135.1717518136265;5863.912041319299;5975.820725378246;5984.790532331347;6001.609895356788;6027.969860150672;5942.494887934401;5998.520118390606;6002.33974262822;6007.068904319837;6008.669523176267;5719.7426115824055;5772.9711351442975;5830.82507524775;5909.172715819875;5909.793157239476;5982.58121931478;6009.819705408845;6033.909491357545;6042.425969532887;6082.695865206633;5859.94140058611;5865.090910908816;5873.853153671193;5885.823425297248;5893.174955506147 18:04:07 INFO - PROCESS | 7167 | |1;ext.html;591.1192323438079;631.1164369882167;646.7348387161264;651.791426743442;665.3379887012422;44623.55376446235;45592.77203613982;45812.54187458124;45910.540894591046;49056;47352.28971565421;47535;47599.52400475994;48118;48147.277790833075;9010.86483702745;9151.130642588943;9200.539973001356;9211.631534738603;9230.307726920475;9009.324300677443;9050.818983620324;9098.044705305947;9100.63597456101;9118.772030699252;9166.86249706255;9174.678886238982;9175.770605734877;9188.1730644242;9214.539273036322;9073.41022833517;9085;9110.0434454382;9115.22520585751;9119.863202051974;8915.643374265022;8949.910500895037;8967.372283940127;9001.369904106716;9016.05331440196;43084.56915430837;43881.56118438807;44261.557384426065;44269;44324.77837610824;4051.6556092732153;4265.637420819234;4495;4529.2526733089;4565.269556870885;33006.50490242648;33593.6640633593;33894.15264618404;33929.32141357184;35372.82313588416;4047.858324958642;4058.4115303281155;4064.552899181088;4067.491563554556;4082.3468245080644;360179;361966.1901690501;363144;364033;366313;33902.152446189044;34616.48075278873;37700.43449348262;63074.36925630685;63339.683301583194;38404.615953840665;40241.59758402437;40524.39213411801;40560.79719601442;40717.389239161435;16302.755458667893;16341.673166536602;16348.427805026768;16370.590735231715;16465.6706865862;13337.333133343294;13608.251546164858;13622.318884055758;13631.113977591425;13684;8996.685116020908;9106.043865394171;9137.588808503633;9149.908500914906;9172.587233574504;3421.367047096295;3440.1055725511546;3497.283056973365;3499.545059142295;3536.3104194682305;1010.075780660702;1080.4921686807188;1202.5430336472084;1230.4893469210178;1235.172434468908;33726.17226936944;33823.154421139174;33871.49192762111;33919.152021199174;34156.48765268523;1175.3183153770963;1204.295487140033;1232.734961983178;1291.6577107066635;1328.774108401574;17709.20308586117;17710.822891771175;17758.822411775975;17765.644687106185;17841.375551855625;686749;911916;1002028;1014730;1019460;58722.41277587255;58931.410685892595;59332.11001834976;59364;59505;1478.4308041403922;1492.8208614966275;1500.8724258437937;1502.66190107225;1513.530805450314;30874.382512350076;31369.215769605944;31574.368512630077;31907.521387178745;32697.836510817295;49640.255396168366;50244.24633630572;50269.24596131134;50333.24500132428;50407.49592504028;424758;433873;434879;435117;435479;29318.26704332409;29704.257393565334;29738.405231895675;29746.702532974392;29746.702532974392;46256.53743462522;46793.53206467892;47006.294905577124;47805;47963.5203647973;39032.41451378288;39280.2143957125;39384.40923386094;39555.60444395634;40789.38815917823;38728;39238.607613923494;39292.60707392889;39828.60171398249;40368.39447408233;39582;40386.39420408755;40792.79603601963;40951;41169.1766164681;33366.83316583402;34772.47841282332;35011.82494087513;35189.29621407609;35199.29601407906;27855.442891141658;28258;28352;28356.43287134287;28490.287742806595 18:04:07 INFO - PROCESS | 7167 | |2;jquery.html;430.33728058789467;430.54362375881567;436.9344598310253;441.45050871441254;444.8265176581132;18547.907260463697;19283.421497355084;20302.289419870307;20322.390328290174;20342.18631254748;19080.427587172406;19577.510562235915;19686.606267874635;20367.694484582742;20453.48866278344;5758.82723518293;5942.792002279921;5976.163337132783;5980;5982.461578457938;5436.945630543703;5804.129380592903;5848.736806843681;5905.9409405906035;5910.202122713422;5667.121596152603;5847.5614328925285;5861.472467477926;5882.470577648032;5883.44107309807;5995.490383317423;6059.909101363483;6071.150038994522;6078.179445774808;6100.267967843843;5722.313322401338;5801.887733721777;5872.647641141545;5900.498457631106;5916.319623243339;12913.935430322883;12929.87070129296;12963.740725185538;12976.740465190738;13099.47602095915;2338.672585837984;2406.554787364326;2418.4316685578874;2683.2486903667004;2757.765589924859;9856.950715246378;10393.688189354332;10479.214058945534;10746.516406761715;10924.836127458095;1925;1943.4849764812336;1994.7706013808452;1999.990000050005;2030.9289174878809;83410.16589834084;87567;90828.09171908263;91499.08500914973;91854.54072729661;11376.146788990858;11466.48400821965;11597.536098556133;11833.822492662617;11894.643160705193;16517.174141292886;16567.66864662724;16600.6679866402;16678.249478773243;16681.416150434678;8635.956820215984;8845.911540884637;8885.71157182205;8933.508657023796;8936.151065648754;8566.657333706706;8600.741977740678;8670.653173872974;8678.349123815738;8786.472811631322;4383.145286669069;4502.639788816887;5042.672226305279;5081.720505372166;5162.070827251056;2043.5477427087555;2086.4992401823756;2099.979000210009;2101.7688054314012;2113.492761737172;965.4062751407834;1066.5840322274319;1123.0902968595465;1140.6064907606863;1163.6799880033059;17681;19304.420867374;19814.108365123604;19939.900300498695;20094.69857952132;1010.7169992402139;1044.4412239452008;1054.3624495490587;1055.5672174408455;1115.2249186815247;10967.670969870916;11234;11337.43312834355;11399.829002564968;11467.598634047936;527070;546892;547488;554580;567327;99893;100752.49623751834;102276.48861755793;102728.97271027343;103972;1059.433203236265;1075.9408232547285;1123.9438028098562;1146.9082473402275;1156.2022204678744;17691.38080167188;17936.641267174844;18010;18140.365087221882;18150.27398904082;41359.793201033805;41576;42256.15487690167;43626;44156.337654934556;60386.39613603808;60684.08973865307;60693.39306607054;61541;62530.06204907021;8034.87947680797;8282.958585207036;8682.392232543662;8753.47479151253;9024.458532488072;11876;12899.677508062374;13507.527236547066;14063.437462501795;14415.918806089796;12126.151169418055;12365.814512782496;12402.875971240172;12433.751324973631;12587.05597080241;11944.581939632071;12088.697782555506;12178.878211218129;12509.937450313055;12546.1844980076;11457.541698331974;12158.939205303917;12190.02479801596;12614.684632883884;13134.60596182116;8885.644574217218;9143.908560914571;9204.316919216943;9228.35401521887;9274.489903055397;9461.337706360764;12543.49826006986;12587.244765313744;12595.811062833882;12652.620421387373 18:04:07 INFO - PROCESS | 7167 | |3;mootools.html;1589.2451085734274;1624.8375162483749;1817.6909925312696;1926.9036548172605;1953.5116220944765;8516.957415212915;9093.363464557484;9211.401258918166;9881.901180988198;9914.256430767704;9271.768205794842;9588.664396746115;9615.471149086798;9620.518974051305;9638.566264518096;2421.1283937782428;2452.2520631207476;2463.581191197492;2465.0139944022353;2468.7531246875346;2349.0251545608553;2375.70303712036;2399.8200134989856;2400.4838959623676;2403.399150212447;2486.8880900359527;2493.800495960319;2495.5757521221344;2501.7248102708686;2510.6736124303907;2298.9310320690324;2314;2319.93040208794;2372.4424760181346;2414.5050264695697;2345.683332750074;2424.175780234711;2435.147698305597;2471.456279618481;2480.1443501991785;9503.097205765442;9578.90421095794;9667.758306042335;9673.22614190863;9674.177694895941;5355.464453554652;5431.891362172734;5443.2107344434835;5444.6188766786345;5444.863878403072;3231.5314279429585;3293.4895091260655;3347.715444187247;3385.4583266677214;3391.491276308549;1086.5056399338282;1089.9564017439293;1096.8628921384827;1106.2643342177441;1128.9096872250282;13295.401706923212;13327.600171994856;13331.133476324008;13336.333183340794;13386.263755493444;4748.501407352247;4864.294677271847;4896.755162241873;4897.094037603055;4949.455559888409;11047.613333533287;11106.666799996014;11153.330800152016;11161.386123763108;11179.720506987227;5449.6730196188355;5516.282883225155;5523.696196709139;5529.336479622471;5699.031164701928;4474.284114541722;5010.724410157476;5011.924821127686;5153.6907785532985;5175.06848767218;4291.313389857608;4362.367456718822;4435.822567097344;4456.420665313553;4473.060657261946;1340.9530666426629;1357.7352416278732;1364.7543442180304;1389.4303335632544;1414.9529348282404;967.8209531236744;969.6363863551169;1003.1122456625939;1003.7239759066169;1042.8070806900748;6180.412860778219;6273.62358258506;6364.681765911779;6372.139761132281;6458.935410645833;439.78670344882704;442.15989619722785;447.6508323507604;454.08275283926287;469.4038571014792;4255.723377980421;4304.913901721948;4317.41714868495;4320.1143765527995;4339.370791235253;11939.164258501994;12271.57049503263;12298.754024919452;12326.938365308117;12390.194637348544;11382.203245772716;11785.292882427082;12186.390680465942;12201.755964880831;12278.938605307096;8751.256143227769;8786.25316848075;8889.377743557889;8959.059298773534;8970.686025989058;6462.709178086903;6669.866602667822;6677.966610166918;6786.0838786765125;6790.830229244309;10613.469326533488;10748.301360411548;10844.67465976022;10903.727406814893;10980.341179529254;10883.292585981886;10922.12622990143;10927.016568508872;11081.11351091927;11091.445427728742;7731.7680469586;7738.342240909586;7780;7911.208879112273;8127.674893004214;9102.908970910206;9144.497052662167;9215.400998935047;9235.445873247627;9264.95367523158;8178.959105204436;8384.371172162235;8423.241908228289;8509.404341696021;8525.317974562144;7984.041914970241;7999.880001800094;8097.149799270992;8149.144339844231;8257.133001034805;7473.701051957861;7482.887756683763;7729.536227826348;7790.571518566307;7933.8413231736195;5411.918821217763;5501.642393244426;5628.802991895264;5629.127485239795;5675.375708672125;5414.620976531605;5425.565954723534;5465.316835395575;5493.642913210629;5546.500814926676 18:04:07 INFO - PROCESS | 7167 | |4;prototype.html;347.81044330839705;352.8676746220167;353.77712041413906;354.9449835275532;356.0333694020734;5596.776128954837;5705.00487244197;5848.853778655531;5891.263592050994;5902.8124812601145;5697.515711164546;5754;5786.479216870481;5792.161840698059;5811.593188476808;4545.068345952974;4553.544645535437;4554.178328668534;4558.475775285851;4567.693314876;4472.731636101845;4491.348754430605;4513.79687914043;4521.276595744682;4560.612347950411;4439.445069366329;4458.308962110862;4469.385409535425;4497.70764900282;4508.143452743984;4446.577575130357;4507.819687212507;4522.728636281817;4574.313852922055;4579.885502862422;3904.531456225243;4007.519097708294;4011.679065674768;4099.795010249505;4112.650424713873;5551.195076713854;5567.47109024642;5613.831585052455;5622;5655.971720141373;5139.10065738498;5141.38303403594;5185.144451165553;5199.844004679828;5206.193040078756;5825.941740582624;6025.849353766191;6036.215292012054;6042.909356359658;6076.969615151896;4390.956090439118;4411.382406463098;4438.556144385568;4452.79774460897;4453.332000199964;6215.285242197115;6260.280067792217;6286.748530058792;6322.241331040304;6324.71538780756;4095.91808163841;4328.394024836525;4347.56524347569;4351.195028919597;4352.042550638855;4370.409994650745;4388.05656783793;4403.757793321398;4412.294032954712;4417.425734654475;5008.398992120969;5029.446760856303;5030.823921162815;5079.619028572872;5087.567556757643;5802;5979.760809567656;6002.189704389939;6028.8794224116145;6046.3651316612;1563.9296231669603;1597.7683235930724;1597.840215978393;1608.3727346334938;1609.5251900689325;999.2905037423366;1020.9897901020895;1031.504877658713;1038.2783965144304;1044.8850626431085;5302.28419163408;5326.36083669962;5331.546818520469;5378.489043540857;5399.514043736004;5437.510624043776;5525.502704756591;5545.223668686387;5571.272905399339;5585.273914391103;5238.768889311009;5342.2787923630585;5545.750441230154;6029.155918171459;6056.091586262008;3358.714509266691;3385.4075536781456;3394.5587073680263;3399.8980030599123;3404.268082362304;6120.469882529368;6517.250516190604;6518.674066296666;6564.6389448580785;6584;6321.1782468278825;6347.873042539123;6357.427831495188;6383.585066970632;6416.903746443807;6311.873762524724;6549.443297319686;6559.704813283413;6587.670616469253;6604.787396222223;6162.630242185483;6211.850807600608;6246;6270.561060725706;6292.811215663537;6187.133801267916;6211.378862113933;6211.689415529115;6222.253329600477;6232.470240029648;6212;6465.967670161619;6473.8705225896165;6474.255460622088;6567.474602031731;4322.351647252937;4337.349397590387;4368.126374725004;4374.518802931739;4391.780410979374;5996.760129594942;6043.637381757108;6238.161636455493;6342.968285158545;6357.396047375492;6054.576179667381;6055.333913269625;6096.237970253718;6096.634201947897;6106.69466526663;5950.910736339045;6045.939540604538;6057.666828324484;6082.543809214415;6094;5886.823395298148;5997.91003134962;6006.069059295816;6007.939920600738;6025.6083354581815;6103.969480152571;6141.785037523665;6181.690915454119;6186.958303759839;6198.2871969722255;5858.8242352729485;5899.528037756883;6028.939710603014;6051.152838602688;6056.273247210187 18:04:07 INFO - PROCESS | 7167 | |5;yui.html;801.8636831738604;815.388458656008;844.7761343244041;846.9661213551458;891.8662200669895;14657.267136643166;16538.669226615475;16551;16607.833921660796;16610;15319.157446340447;15562.45531406401;15658.138802365866;15699.764503532457;15748.291326890288;863.6329559937033;869.521763030334;873.1355957601992;873.4366333714751;873.4759144513305;869.9130086991282;872.2019352292644;872.7512658892217;876.8903887014123;877.4165180155221;920.4109370003204;927.5269612497641;928.2110206324604;928.5450129436595;929.8372784762673;903.4759839293195;912.8493798523269;914.085914085914;914.2822884036;914.9542522873896;676.8781619308522;677.9254282028973;678.5860625018735;678.6131904814258;679.4734081087148;14846.777298340534;15073.246337683073;15098.245087745569;15115.622109447242;15119;13985.440582376692;14012.579622611338;14039.298035098307;14139.434422623082;14205.076670016417;11921.165518413714;11924.46339914706;12089.214201076902;12241.081918856122;12527.812082818675;3980.7611543307203;3996.3406038003986;4034.072163402434;4060.614241647039;4132.979335103305;71681;72227.2777272231;72440;72893.99999999948;73408.63295683487;10225.744356391;10310.32982856112;10342.793144137075;10432.530536125892;10461.215408844215;20171.193152274038;20241.79758202399;20349.796502035086;20352.79647203509;20385.898070509553;8557.957210214034;8566.571671416405;8567.828643427096;8752.737417877473;8987.820243595092;4816.975915120472;4849.539293767087;4865.878353041202;4873.171560834667;4958.479359667183;3250.723688486458;3371.713404360657;3373.8819141329936;3429.8113603751535;3436.261203841186;615.5567991046439;635.4217661927623;635.4916067146357;635.9618422894641;639.9008153736179;665.4244078871741;719.5790462579345;721.2390927571463;727.3163226567116;735.8197241675824;9513.667021654348;9520.23838092951;9595.42427454355;9603.607476915808;9619.56711947964;602.3133627664466;648.1217949678119;666.5600703535644;738.9889151662729;747.9813004674818;4675.345451636774;4764.737939413296;4775.068861572029;4804.471508134103;4830.734309613005;111992;113923;114520.42739786248;115426;116933.41533292449;60856.391436085076;77109;86388;94960.52519737357;95078.57382139274;58339.416605834245;68911.65544172247;94598.52700736452;95100.52449737708;95714;10298.22763292771;10420.47897605132;10713.196510261605;10757.632305740153;10859.674209773719;41460;51450.74274628603;53911.46088539221;54456.455435446725;56408.435915640315;47408.28887566758;60861;77280;78189.60905195438;78861.21138788539;12807.61577152687;12885;13152.868471315165;13212.867871321549;13451;14689.338979745724;14691.706165876836;14788.778168327268;14954.327055282756;15574;14219.573412797632;14220.431182752574;14222;14930.477433289783;15258.465953691568;14586.4894728684;14695.779563306773;14794.63013424673;15018.399264029316;15056.623584410478;13363.3986470611;13473.191608503521;13651.249181295125;13710.52013179534;13735.862641373858;11445.942770286096;11454.885451145381;11494.885051149382;11524.711882203012;11685.474153662935;11882.46528906184;12204.32876191818;12344.876551234733;12360;12589.559365422167 18:04:07 INFO - PROCESS | 7167 | __end_tp_report 18:04:07 INFO - PROCESS | 7167 | __start_cc_report 18:04:07 INFO - PROCESS | 7167 | _x_x_mozilla_cycle_collect,339 18:04:07 INFO - PROCESS | 7167 | __end_cc_report 18:04:07 INFO - PROCESS | 7167 | __startTimestamp1466643847307__endTimestamp 18:04:07 INFO - PROCESS | 7167 | 18:04:07 INFO - PROCESS | 7167 | ------- Summary: start ------- 18:04:07 INFO - PROCESS | 7167 | Number of tests: 6 18:04:07 INFO - PROCESS | 7167 | 18:04:07 INFO - PROCESS | 7167 | [#0] dojo.html Cycles:165 Average:5643.71 Median:5893.17 stddev:639.22 (10.8%) stddev-sans-first:615.27 18:04:07 INFO - PROCESS | 7167 | Values: 3347.5 3363.6 3370.9 3377.1 3389.8 5508.4 5530.7 5552.9 5576.4 5602.9 5538.5 5613.9 5628.2 5631.0 5649.2 5045.1 5084.5 5143.6 5152.8 5169.7 5032.5 5033.9 5078.4 5171.6 5183.4 5072.5 5115.9 5129.5 5136.9 5155.4 5128.0 5171.3 5181.5 5207.7 5239.7 4920.7 5104.3 5116.9 5161.7 5182.6 5443.5 5496.9 5514.8 5517.0 5547.2 6070.9 6101.6 6117.8 6119.1 6124.1 5933.0 6074.3 6144.6 6167.7 6183.7 5705.9 5755.9 5769.8 5777.7 5787.5 6244.7 6251.4 6255.8 6273.1 6275.8 5769.8 5896.2 5902.1 6023.0 6031.0 6049.0 6050.0 6053.2 6089.1 6097.8 5949.1 6063.1 6065.4 6075.6 6091.4 5819.2 5981.7 6000.9 6043.2 6059.7 4643.4 4644.8 4650.0 4656.3 4693.5 4174.5 4181.0 4196.3 4207.1 4212.3 5645.2 5840.3 5862.6 5876.0 5941.1 6015.4 6025.7 6082.3 6118.3 6141.6 5740.9 5884.4 5885.6 5908.0 5908.0 5184.5 5192.9 5205.0 5228.4 5289.3 6295.2 6305.7 6322.1 6333.8 6337.6 5935.1 6081.2 6086.9 6089.1 6096.1 6263.6 6304.1 6307.1 6391.5 6395.4 5970.8 6016.5 6019.0 6024.9 6040.4 5924.6 6022.1 6112.4 6117.1 6135.2 5863.9 5975.8 5984.8 6001.6 6028.0 5942.5 5998.5 6002.3 6007.1 6008.7 5719.7 5773.0 5830.8 5909.2 5909.8 5982.6 6009.8 6033.9 6042.4 6082.7 5859.9 5865.1 5873.9 5885.8 5893.2 18:04:07 INFO - PROCESS | 7167 | 18:04:07 INFO - PROCESS | 7167 | [#1] ext.html Cycles:180 Average:70404.76 Median:22288.02 stddev:171002.51 (767.2%) stddev-sans-first:171401.87 18:04:07 INFO - PROCESS | 7167 | Values: 591.1 631.1 646.7 651.8 665.3 44623.6 45592.8 45812.5 45910.5 49056.0 47352.3 47535.0 47599.5 48118.0 48147.3 9010.9 9151.1 9200.5 9211.6 9230.3 9009.3 9050.8 9098.0 9100.6 9118.8 9166.9 9174.7 9175.8 9188.2 9214.5 9073.4 9085.0 9110.0 9115.2 9119.9 8915.6 8949.9 8967.4 9001.4 9016.1 43084.6 43881.6 44261.6 44269.0 44324.8 4051.7 4265.6 4495.0 4529.3 4565.3 33006.5 33593.7 33894.2 33929.3 35372.8 4047.9 4058.4 4064.6 4067.5 4082.3 360179.0 361966.2 363144.0 364033.0 366313.0 33902.2 34616.5 37700.4 63074.4 63339.7 38404.6 40241.6 40524.4 40560.8 40717.4 16302.8 16341.7 16348.4 16370.6 16465.7 13337.3 13608.3 13622.3 13631.1 13684.0 8996.7 9106.0 9137.6 9149.9 9172.6 3421.4 3440.1 3497.3 3499.5 3536.3 1010.1 1080.5 1202.5 1230.5 1235.2 33726.2 33823.2 33871.5 33919.2 34156.5 1175.3 1204.3 1232.7 1291.7 1328.8 17709.2 17710.8 17758.8 17765.6 17841.4 686749.0 911916.0 1002028.0 1014730.0 1019460.0 58722.4 58931.4 59332.1 59364.0 59505.0 1478.4 1492.8 1500.9 1502.7 1513.5 30874.4 31369.2 31574.4 31907.5 32697.8 49640.3 50244.2 50269.2 50333.2 50407.5 424758.0 433873.0 434879.0 435117.0 435479.0 29318.3 29704.3 29738.4 29746.7 29746.7 46256.5 46793.5 47006.3 47805.0 47963.5 39032.4 39280.2 39384.4 39555.6 40789.4 38728.0 39238.6 39292.6 39828.6 40368.4 39582.0 40386.4 40792.8 40951.0 41169.2 33366.8 34772.5 35011.8 35189.3 35199.3 27855.4 28258.0 28352.0 28356.4 28490.3 18:04:07 INFO - PROCESS | 7167 | 18:04:07 INFO - PROCESS | 7167 | [#2] jquery.html Cycles:180 Average:31259.93 Median:11248.52 stddev:90548.23 (805.0%) stddev-sans-first:90772.65 18:04:07 INFO - PROCESS | 7167 | Values: 430.3 430.5 436.9 441.5 444.8 18547.9 19283.4 20302.3 20322.4 20342.2 19080.4 19577.5 19686.6 20367.7 20453.5 5758.8 5942.8 5976.2 5980.0 5982.5 5436.9 5804.1 5848.7 5905.9 5910.2 5667.1 5847.6 5861.5 5882.5 5883.4 5995.5 6059.9 6071.2 6078.2 6100.3 5722.3 5801.9 5872.6 5900.5 5916.3 12913.9 12929.9 12963.7 12976.7 13099.5 2338.7 2406.6 2418.4 2683.2 2757.8 9857.0 10393.7 10479.2 10746.5 10924.8 1925.0 1943.5 1994.8 2000.0 2030.9 83410.2 87567.0 90828.1 91499.1 91854.5 11376.1 11466.5 11597.5 11833.8 11894.6 16517.2 16567.7 16600.7 16678.2 16681.4 8636.0 8845.9 8885.7 8933.5 8936.2 8566.7 8600.7 8670.7 8678.3 8786.5 4383.1 4502.6 5042.7 5081.7 5162.1 2043.5 2086.5 2100.0 2101.8 2113.5 965.4 1066.6 1123.1 1140.6 1163.7 17681.0 19304.4 19814.1 19939.9 20094.7 1010.7 1044.4 1054.4 1055.6 1115.2 10967.7 11234.0 11337.4 11399.8 11467.6 527070.0 546892.0 547488.0 554580.0 567327.0 99893.0 100752.5 102276.5 102729.0 103972.0 1059.4 1075.9 1123.9 1146.9 1156.2 17691.4 17936.6 18010.0 18140.4 18150.3 41359.8 41576.0 42256.2 43626.0 44156.3 60386.4 60684.1 60693.4 61541.0 62530.1 8034.9 8283.0 8682.4 8753.5 9024.5 11876.0 12899.7 13507.5 14063.4 14415.9 12126.2 12365.8 12402.9 12433.8 12587.1 11944.6 12088.7 12178.9 12509.9 12546.2 11457.5 12158.9 12190.0 12614.7 13134.6 8885.6 9143.9 9204.3 9228.4 9274.5 9461.3 12543.5 12587.2 12595.8 12652.6 18:04:07 INFO - PROCESS | 7167 | 18:04:07 INFO - PROCESS | 7167 | [#3] mootools.html Cycles:180 Average:6216.16 Median:4473.67 stddev:3634.41 (81.2%) stddev-sans-first:3627.97 18:04:07 INFO - PROCESS | 7167 | Values: 1589.2 1624.8 1817.7 1926.9 1953.5 8517.0 9093.4 9211.4 9881.9 9914.3 9271.8 9588.7 9615.5 9620.5 9638.6 2421.1 2452.3 2463.6 2465.0 2468.8 2349.0 2375.7 2399.8 2400.5 2403.4 2486.9 2493.8 2495.6 2501.7 2510.7 2298.9 2314.0 2319.9 2372.4 2414.5 2345.7 2424.2 2435.1 2471.5 2480.1 9503.1 9578.9 9667.8 9673.2 9674.2 5355.5 5431.9 5443.2 5444.6 5444.9 3231.5 3293.5 3347.7 3385.5 3391.5 1086.5 1090.0 1096.9 1106.3 1128.9 13295.4 13327.6 13331.1 13336.3 13386.3 4748.5 4864.3 4896.8 4897.1 4949.5 11047.6 11106.7 11153.3 11161.4 11179.7 5449.7 5516.3 5523.7 5529.3 5699.0 4474.3 5010.7 5011.9 5153.7 5175.1 4291.3 4362.4 4435.8 4456.4 4473.1 1341.0 1357.7 1364.8 1389.4 1415.0 967.8 969.6 1003.1 1003.7 1042.8 6180.4 6273.6 6364.7 6372.1 6458.9 439.8 442.2 447.7 454.1 469.4 4255.7 4304.9 4317.4 4320.1 4339.4 11939.2 12271.6 12298.8 12326.9 12390.2 11382.2 11785.3 12186.4 12201.8 12278.9 8751.3 8786.3 8889.4 8959.1 8970.7 6462.7 6669.9 6678.0 6786.1 6790.8 10613.5 10748.3 10844.7 10903.7 10980.3 10883.3 10922.1 10927.0 11081.1 11091.4 7731.8 7738.3 7780.0 7911.2 8127.7 9102.9 9144.5 9215.4 9235.4 9265.0 8179.0 8384.4 8423.2 8509.4 8525.3 7984.0 7999.9 8097.1 8149.1 8257.1 7473.7 7482.9 7729.5 7790.6 7933.8 5411.9 5501.6 5628.8 5629.1 5675.4 5414.6 5425.6 5465.3 5493.6 5546.5 18:04:07 INFO - PROCESS | 7167 | 18:04:07 INFO - PROCESS | 7167 | [#4] prototype.html Cycles:180 Average:5077.46 Median:5617.92 stddev:1490.01 (26.5%) stddev-sans-first:1451.29 18:04:07 INFO - PROCESS | 7167 | Values: 347.8 352.9 353.8 354.9 356.0 5596.8 5705.0 5848.9 5891.3 5902.8 5697.5 5754.0 5786.5 5792.2 5811.6 4545.1 4553.5 4554.2 4558.5 4567.7 4472.7 4491.3 4513.8 4521.3 4560.6 4439.4 4458.3 4469.4 4497.7 4508.1 4446.6 4507.8 4522.7 4574.3 4579.9 3904.5 4007.5 4011.7 4099.8 4112.7 5551.2 5567.5 5613.8 5622.0 5656.0 5139.1 5141.4 5185.1 5199.8 5206.2 5825.9 6025.8 6036.2 6042.9 6077.0 4391.0 4411.4 4438.6 4452.8 4453.3 6215.3 6260.3 6286.7 6322.2 6324.7 4095.9 4328.4 4347.6 4351.2 4352.0 4370.4 4388.1 4403.8 4412.3 4417.4 5008.4 5029.4 5030.8 5079.6 5087.6 5802.0 5979.8 6002.2 6028.9 6046.4 1563.9 1597.8 1597.8 1608.4 1609.5 999.3 1021.0 1031.5 1038.3 1044.9 5302.3 5326.4 5331.5 5378.5 5399.5 5437.5 5525.5 5545.2 5571.3 5585.3 5238.8 5342.3 5545.8 6029.2 6056.1 3358.7 3385.4 3394.6 3399.9 3404.3 6120.5 6517.3 6518.7 6564.6 6584.0 6321.2 6347.9 6357.4 6383.6 6416.9 6311.9 6549.4 6559.7 6587.7 6604.8 6162.6 6211.9 6246.0 6270.6 6292.8 6187.1 6211.4 6211.7 6222.3 6232.5 6212.0 6466.0 6473.9 6474.3 6567.5 4322.4 4337.3 4368.1 4374.5 4391.8 5996.8 6043.6 6238.2 6343.0 6357.4 6054.6 6055.3 6096.2 6096.6 6106.7 5950.9 6045.9 6057.7 6082.5 6094.0 5886.8 5997.9 6006.1 6007.9 6025.6 6104.0 6141.8 6181.7 6187.0 6198.3 5858.8 5899.5 6028.9 6051.2 6056.3 18:04:07 INFO - PROCESS | 7167 | 18:04:07 INFO - PROCESS | 7167 | [#5] yui.html Cycles:180 Average:20115.26 Median:23067.67 stddev:28316.01 (122.8%) stddev-sans-first:28358.30 18:04:07 INFO - PROCESS | 7167 | Values: 801.9 815.4 844.8 847.0 891.9 14657.3 16538.7 16551.0 16607.8 16610.0 15319.2 15562.5 15658.1 15699.8 15748.3 863.6 869.5 873.1 873.4 873.5 869.9 872.2 872.8 876.9 877.4 920.4 927.5 928.2 928.5 929.8 903.5 912.8 914.1 914.3 915.0 676.9 677.9 678.6 678.6 679.5 14846.8 15073.2 15098.2 15115.6 15119.0 13985.4 14012.6 14039.3 14139.4 14205.1 11921.2 11924.5 12089.2 12241.1 12527.8 3980.8 3996.3 4034.1 4060.6 4133.0 71681.0 72227.3 72440.0 72894.0 73408.6 10225.7 10310.3 10342.8 10432.5 10461.2 20171.2 20241.8 20349.8 20352.8 20385.9 8558.0 8566.6 8567.8 8752.7 8987.8 4817.0 4849.5 4865.9 4873.2 4958.5 3250.7 3371.7 3373.9 3429.8 3436.3 615.6 635.4 635.5 636.0 639.9 665.4 719.6 721.2 727.3 735.8 9513.7 9520.2 9595.4 9603.6 9619.6 602.3 648.1 666.6 739.0 748.0 4675.3 4764.7 4775.1 4804.5 4830.7 111992.0 113923.0 114520.4 115426.0 116933.4 60856.4 77109.0 86388.0 94960.5 95078.6 58339.4 68911.7 94598.5 95100.5 95714.0 10298.2 10420.5 10713.2 10757.6 10859.7 41460.0 51450.7 53911.5 54456.5 56408.4 47408.3 60861.0 77280.0 78189.6 78861.2 12807.6 12885.0 13152.9 13212.9 13451.0 14689.3 14691.7 14788.8 14954.3 15574.0 14219.6 14220.4 14222.0 14930.5 15258.5 14586.5 14695.8 14794.6 15018.4 15056.6 13363.4 13473.2 13651.2 13710.5 13735.9 11445.9 11454.9 11494.9 11524.7 11685.5 11882.5 12204.3 12344.9 12360.0 12589.6 18:04:07 INFO - PROCESS | 7167 | -------- Summary: end -------- 18:04:07 INFO - PROCESS | 7167 | 18:04:07 INFO - TEST-INFO | 7167: exit 0 18:04:07 INFO - TEST-OK | dromaeo_css | took 1109181ms 18:04:07 INFO - TEST-START | kraken 18:04:07 INFO - operating with platform_type : linux_ 18:04:07 INFO - Initialising browser for kraken test... 18:04:07 INFO - TEST-INFO | started process 7406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo6CVnZ/profile http://localhost:59435/getInfo.html) 18:04:11 INFO - PROCESS | 7406 | __metrics Screen width/height:1600/1200 18:04:11 INFO - PROCESS | 7406 | colorDepth:24 18:04:11 INFO - PROCESS | 7406 | Browser inner width/height: 1024/697 18:04:11 INFO - PROCESS | 7406 | __metrics 18:04:12 ERROR - PROCESS | 7406 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:04:13 INFO - TEST-INFO | 7406: exit 0 18:04:13 INFO - Browser initialized. 18:04:13 INFO - Running cycle 1/1 for kraken test... 18:04:13 INFO - TEST-INFO | started process 7538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo6CVnZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:04:25 INFO - PROCESS | 7538 | RSS: Main: 155967488 18:04:25 INFO - PROCESS | 7538 | 18:04:27 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59435/tests/kraken/driver.html?testName=audio-beat-detection) 18:04:28 INFO - PROCESS | 7538 | RSS: Main: 160600064 18:04:28 INFO - PROCESS | 7538 | 18:04:31 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59435/tests/kraken/driver.html?testName=audio-dft) 18:04:31 INFO - PROCESS | 7538 | RSS: Main: 160272384 18:04:31 INFO - PROCESS | 7538 | 18:04:34 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59435/tests/kraken/driver.html?testName=audio-fft) 18:04:35 INFO - PROCESS | 7538 | RSS: Main: 161316864 18:04:35 INFO - PROCESS | 7538 | 18:04:37 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59435/tests/kraken/driver.html?testName=audio-oscillator) 18:04:37 INFO - PROCESS | 7538 | RSS: Main: 161312768 18:04:37 INFO - PROCESS | 7538 | 18:04:40 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:04:40 INFO - PROCESS | 7538 | RSS: Main: 161079296 18:04:40 INFO - PROCESS | 7538 | 18:04:43 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59435/tests/kraken/driver.html?testName=imaging-darkroom) 18:04:44 INFO - PROCESS | 7538 | RSS: Main: 161009664 18:04:44 INFO - PROCESS | 7538 | 18:04:47 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59435/tests/kraken/driver.html?testName=imaging-desaturate) 18:04:48 INFO - PROCESS | 7538 | RSS: Main: 161517568 18:04:48 INFO - PROCESS | 7538 | 18:04:51 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59435/tests/kraken/driver.html?testName=json-parse-financial) 18:04:51 INFO - PROCESS | 7538 | RSS: Main: 161239040 18:04:51 INFO - PROCESS | 7538 | 18:04:53 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:04:54 INFO - PROCESS | 7538 | RSS: Main: 160968704 18:04:54 INFO - PROCESS | 7538 | 18:04:55 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59435/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:04:56 INFO - PROCESS | 7538 | RSS: Main: 161386496 18:04:56 INFO - PROCESS | 7538 | 18:04:58 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:04:59 INFO - PROCESS | 7538 | RSS: Main: 161800192 18:04:59 INFO - PROCESS | 7538 | 18:05:01 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:05:02 INFO - PROCESS | 7538 | RSS: Main: 161660928 18:05:02 INFO - PROCESS | 7538 | 18:05:04 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:05:05 INFO - PROCESS | 7538 | RSS: Main: 162013184 18:05:05 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | Cycle 1(1): loaded http://localhost:59435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59435/tests/kraken/driver.html?testName=ai-astar) 18:05:07 INFO - PROCESS | 7538 | RSS: Main: 161935360 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | __start_tp_report 18:05:07 INFO - PROCESS | 7538 | _x_x_mozilla_page_load 18:05:07 INFO - PROCESS | 7538 | _x_x_mozilla_page_load_details 18:05:07 INFO - PROCESS | 7538 | |i|pagename|runs| 18:05:07 INFO - PROCESS | 7538 | |0;ai-astar;114;107;110;111;112;110;111;109;111;112 18:05:07 INFO - PROCESS | 7538 | |1;audio-beat-detection;154;126;155;172;126;153;161;126;187;134 18:05:07 INFO - PROCESS | 7538 | |2;audio-dft;163;161;160;162;162;163;164;164;162;162 18:05:07 INFO - PROCESS | 7538 | |3;audio-fft;76;76;75;169;76;77;76;75;174;75 18:05:07 INFO - PROCESS | 7538 | |4;audio-oscillator;87;84;150;84;84;86;133;85;85;147 18:05:07 INFO - PROCESS | 7538 | |5;imaging-gaussian-blur;118;117;117;118;117;117;118;118;119;117 18:05:07 INFO - PROCESS | 7538 | |6;imaging-darkroom;147;148;147;147;147;151;147;147;147;149 18:05:07 INFO - PROCESS | 7538 | |7;imaging-desaturate;95;95;98;96;95;96;96;95;96;95 18:05:07 INFO - PROCESS | 7538 | |8;json-parse-financial;62;53;53;52;55;55;53;56;53;53 18:05:07 INFO - PROCESS | 7538 | |9;json-stringify-tinderbox;59;60;60;59;59;58;59;59;61;60 18:05:07 INFO - PROCESS | 7538 | |10;stanford-crypto-aes;77;77;77;78;78;78;77;77;107;80 18:05:07 INFO - PROCESS | 7538 | |11;stanford-crypto-ccm;121;130;118;126;133;116;137;124;128;135 18:05:07 INFO - PROCESS | 7538 | |12;stanford-crypto-pbkdf2;157;154;159;151;155;153;161;154;156;161 18:05:07 INFO - PROCESS | 7538 | |13;stanford-crypto-sha256-iterative;63;63;64;61;61;61;62;62;61;61 18:05:07 INFO - PROCESS | 7538 | __end_tp_report 18:05:07 INFO - PROCESS | 7538 | __start_cc_report 18:05:07 INFO - PROCESS | 7538 | _x_x_mozilla_cycle_collect,861 18:05:07 INFO - PROCESS | 7538 | __end_cc_report 18:05:07 INFO - PROCESS | 7538 | __startTimestamp1466643907472__endTimestamp 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | ------- Summary: start ------- 18:05:07 INFO - PROCESS | 7538 | Number of tests: 14 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.89 (1.7%) stddev-sans-first:1.58 18:05:07 INFO - PROCESS | 7538 | Values: 114.0 107.0 110.0 111.0 112.0 110.0 111.0 109.0 111.0 112.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:154.50 stddev:21.09 (13.7%) stddev-sans-first:22.31 18:05:07 INFO - PROCESS | 7538 | Values: 154.0 126.0 155.0 172.0 126.0 153.0 161.0 126.0 187.0 134.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 18:05:07 INFO - PROCESS | 7538 | Values: 163.0 161.0 160.0 162.0 162.0 163.0 164.0 164.0 162.0 162.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:40.39 (53.1%) stddev-sans-first:42.26 18:05:07 INFO - PROCESS | 7538 | Values: 76.0 76.0 75.0 169.0 76.0 77.0 76.0 75.0 174.0 75.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.50 stddev:28.52 (33.7%) stddev-sans-first:29.69 18:05:07 INFO - PROCESS | 7538 | Values: 87.0 84.0 150.0 84.0 84.0 86.0 133.0 85.0 85.0 147.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 18:05:07 INFO - PROCESS | 7538 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 119.0 117.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:1.34 (0.9%) stddev-sans-first:1.39 18:05:07 INFO - PROCESS | 7538 | Values: 147.0 148.0 147.0 147.0 147.0 151.0 147.0 147.0 147.0 149.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 18:05:07 INFO - PROCESS | 7538 | Values: 95.0 95.0 98.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.92 (5.4%) stddev-sans-first:1.32 18:05:07 INFO - PROCESS | 7538 | Values: 62.0 53.0 53.0 52.0 55.0 55.0 53.0 56.0 53.0 53.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 18:05:07 INFO - PROCESS | 7538 | Values: 59.0 60.0 60.0 59.0 59.0 58.0 59.0 59.0 61.0 60.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:77.50 stddev:9.32 (12.0%) stddev-sans-first:9.80 18:05:07 INFO - PROCESS | 7538 | Values: 77.0 77.0 77.0 78.0 78.0 78.0 77.0 77.0 107.0 80.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:129.00 stddev:7.13 (5.5%) stddev-sans-first:7.25 18:05:07 INFO - PROCESS | 7538 | Values: 121.0 130.0 118.0 126.0 133.0 116.0 137.0 124.0 128.0 135.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:156.50 stddev:3.38 (2.2%) stddev-sans-first:3.57 18:05:07 INFO - PROCESS | 7538 | Values: 157.0 154.0 159.0 151.0 155.0 153.0 161.0 154.0 156.0 161.0 18:05:07 INFO - PROCESS | 7538 | 18:05:07 INFO - PROCESS | 7538 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.09 18:05:07 INFO - PROCESS | 7538 | Values: 63.0 63.0 64.0 61.0 61.0 61.0 62.0 62.0 61.0 61.0 18:05:07 INFO - PROCESS | 7538 | -------- Summary: end -------- 18:05:07 INFO - PROCESS | 7538 | 18:05:08 INFO - TEST-INFO | 7538: exit 0 18:05:08 INFO - TEST-OK | kraken | took 60485ms 18:05:08 INFO - SUITE-END | took 1169s 18:05:08 INFO - Completed test suite (00:19:29) 18:05:08 INFO - javascript benchmark 18:05:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7519.803098496171, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3347.481140423234, 3363.5627368442097, 3370.9325813483715, 3377.138829598453, 3389.7796643218203, 5508.421615730351, 5530.723463826807, 5552.916706249404, 5576.414476479972, 5602.85992850179, 5538.47384498473, 5613.887722245553, 5628.240187574676, 5631.042722737135, 5649.23735295735, 5045.1423258046125, 5084.542391184793, 5143.560336194746, 5152.768125434364, 5169.715665638407, 5032.496750324956, 5033.899322013557, 5078.365204349457, 5171.586273098162, 5183.377994640629, 5072.4673909239555, 5115.923261151086, 5129.461406552315, 5136.8715782105555, 5155.355580552431, 5127.9743601282125, 5171.276021357013, 5181.481851814826, 5207.713575753332, 5239.711815850127, 4920.729359885205, 5104.259882317043, 5116.8998665287145, 5161.690298582097, 5182.559482443997, 5443.537299329561, 5496.862578435531, 5514.834554963358, 5517.0, 5547.195656629807, 6070.908936365958, 6101.633901965896, 6117.785877494311, 6119.082137679339, 6124.11200375943, 5932.9703351483395, 6074.301455332649, 6144.631322120687, 6167.722452489604, 6183.6598987055695, 5705.914411283834, 5755.856103597402, 5769.798057068025, 5777.740001699892, 5787.479126878601, 6244.656543890039, 6251.4061164189325, 6255.812325630239, 6273.059041143773, 6275.843103922347, 5769.826905192851, 5896.233489646404, 5902.144189092557, 6023.0062039763825, 6031.004884194146, 6049.032154855202, 6049.969750151309, 6053.182820319201, 6089.086637004396, 6097.756089756449, 5949.1076338549565, 6063.060225665029, 6065.423784740443, 6075.635461872302, 6091.360407157274, 5819.243498345188, 5981.730822113015, 6000.909986350208, 6043.244594425697, 6059.666718330446, 4643.44278686553, 4644.790984405709, 4649.95350046502, 4656.348111264426, 4693.48371679115, 4174.478190226222, 4180.979095104566, 4196.265653510623, 4207.0954744729415, 4212.262854000538, 5645.1532270159805, 5840.2991641003355, 5862.618929769551, 5876.0, 5941.1088336749835, 6015.368386319461, 6025.728842202111, 6082.2701275847185, 6118.296395914438, 6141.631502109888, 5740.913886291709, 5884.440978107073, 5885.61743486672, 5908.0, 5908.0, 5184.533391994739, 5192.8961420771375, 5205.0, 5228.398734145546, 5289.338832645919, 6295.150154729053, 6305.684715764193, 6322.083297921868, 6333.809985700436, 6337.588056776387, 5935.139404786368, 6081.209442772411, 6086.878262434815, 6089.147519347383, 6096.116063170904, 6263.62418254888, 6304.085907543289, 6307.117003619589, 6391.456726178327, 6395.392437718409, 5970.76116955317, 6016.518678505797, 6019.006863867413, 6024.8795024100145, 6040.426159514839, 5924.555658325729, 6022.066579680157, 6112.365824595983, 6117.113018612187, 6135.1717518136265, 5863.912041319299, 5975.820725378246, 5984.790532331347, 6001.609895356788, 6027.969860150672, 5942.494887934401, 5998.520118390606, 6002.33974262822, 6007.068904319837, 6008.669523176267, 5719.7426115824055, 5772.9711351442975, 5830.82507524775, 5909.172715819875, 5909.793157239476, 5982.58121931478, 6009.819705408845, 6033.909491357545, 6042.425969532887, 6082.695865206633, 5859.94140058611, 5865.090910908816, 5873.853153671193, 5885.823425297248, 5893.174955506147], "value": 5601.434146150127, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.1192323438079, 631.1164369882167, 646.7348387161264, 651.791426743442, 665.3379887012422, 44623.55376446235, 45592.77203613982, 45812.54187458124, 45910.540894591046, 49056.0, 47352.28971565421, 47535.0, 47599.52400475994, 48118.0, 48147.277790833075, 9010.86483702745, 9151.130642588943, 9200.539973001356, 9211.631534738603, 9230.307726920475, 9009.324300677443, 9050.818983620324, 9098.044705305947, 9100.63597456101, 9118.772030699252, 9166.86249706255, 9174.678886238982, 9175.770605734877, 9188.1730644242, 9214.539273036322, 9073.41022833517, 9085.0, 9110.0434454382, 9115.22520585751, 9119.863202051974, 8915.643374265022, 8949.910500895037, 8967.372283940127, 9001.369904106716, 9016.05331440196, 43084.56915430837, 43881.56118438807, 44261.557384426065, 44269.0, 44324.77837610824, 4051.6556092732153, 4265.637420819234, 4495.0, 4529.2526733089, 4565.269556870885, 33006.50490242648, 33593.6640633593, 33894.15264618404, 33929.32141357184, 35372.82313588416, 4047.858324958642, 4058.4115303281155, 4064.552899181088, 4067.491563554556, 4082.3468245080644, 360179.0, 361966.1901690501, 363144.0, 364033.0, 366313.0, 33902.152446189044, 34616.48075278873, 37700.43449348262, 63074.36925630685, 63339.683301583194, 38404.615953840665, 40241.59758402437, 40524.39213411801, 40560.79719601442, 40717.389239161435, 16302.755458667893, 16341.673166536602, 16348.427805026768, 16370.590735231715, 16465.6706865862, 13337.333133343294, 13608.251546164858, 13622.318884055758, 13631.113977591425, 13684.0, 8996.685116020908, 9106.043865394171, 9137.588808503633, 9149.908500914906, 9172.587233574504, 3421.367047096295, 3440.1055725511546, 3497.283056973365, 3499.545059142295, 3536.3104194682305, 1010.075780660702, 1080.4921686807188, 1202.5430336472084, 1230.4893469210178, 1235.172434468908, 33726.17226936944, 33823.154421139174, 33871.49192762111, 33919.152021199174, 34156.48765268523, 1175.3183153770963, 1204.295487140033, 1232.734961983178, 1291.6577107066635, 1328.774108401574, 17709.20308586117, 17710.822891771175, 17758.822411775975, 17765.644687106185, 17841.375551855625, 686749.0, 911916.0, 1002028.0, 1014730.0, 1019460.0, 58722.41277587255, 58931.410685892595, 59332.11001834976, 59364.0, 59505.0, 1478.4308041403922, 1492.8208614966275, 1500.8724258437937, 1502.66190107225, 1513.530805450314, 30874.382512350076, 31369.215769605944, 31574.368512630077, 31907.521387178745, 32697.836510817295, 49640.255396168366, 50244.24633630572, 50269.24596131134, 50333.24500132428, 50407.49592504028, 424758.0, 433873.0, 434879.0, 435117.0, 435479.0, 29318.26704332409, 29704.257393565334, 29738.405231895675, 29746.702532974392, 29746.702532974392, 46256.53743462522, 46793.53206467892, 47006.294905577124, 47805.0, 47963.5203647973, 39032.41451378288, 39280.2143957125, 39384.40923386094, 39555.60444395634, 40789.38815917823, 38728.0, 39238.607613923494, 39292.60707392889, 39828.60171398249, 40368.39447408233, 39582.0, 40386.39420408755, 40792.79603601963, 40951.0, 41169.1766164681, 33366.83316583402, 34772.47841282332, 35011.82494087513, 35189.29621407609, 35199.29601407906, 27855.442891141658, 28258.0, 28352.0, 28356.43287134287, 28490.287742806595], "value": 19795.52883577259, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.33728058789467, 430.54362375881567, 436.9344598310253, 441.45050871441254, 444.8265176581132, 18547.907260463697, 19283.421497355084, 20302.289419870307, 20322.390328290174, 20342.18631254748, 19080.427587172406, 19577.510562235915, 19686.606267874635, 20367.694484582742, 20453.48866278344, 5758.82723518293, 5942.792002279921, 5976.163337132783, 5980.0, 5982.461578457938, 5436.945630543703, 5804.129380592903, 5848.736806843681, 5905.9409405906035, 5910.202122713422, 5667.121596152603, 5847.5614328925285, 5861.472467477926, 5882.470577648032, 5883.44107309807, 5995.490383317423, 6059.909101363483, 6071.150038994522, 6078.179445774808, 6100.267967843843, 5722.313322401338, 5801.887733721777, 5872.647641141545, 5900.498457631106, 5916.319623243339, 12913.935430322883, 12929.87070129296, 12963.740725185538, 12976.740465190738, 13099.47602095915, 2338.672585837984, 2406.554787364326, 2418.4316685578874, 2683.2486903667004, 2757.765589924859, 9856.950715246378, 10393.688189354332, 10479.214058945534, 10746.516406761715, 10924.836127458095, 1925.0, 1943.4849764812336, 1994.7706013808452, 1999.990000050005, 2030.9289174878809, 83410.16589834084, 87567.0, 90828.09171908263, 91499.08500914973, 91854.54072729661, 11376.146788990858, 11466.48400821965, 11597.536098556133, 11833.822492662617, 11894.643160705193, 16517.174141292886, 16567.66864662724, 16600.6679866402, 16678.249478773243, 16681.416150434678, 8635.956820215984, 8845.911540884637, 8885.71157182205, 8933.508657023796, 8936.151065648754, 8566.657333706706, 8600.741977740678, 8670.653173872974, 8678.349123815738, 8786.472811631322, 4383.145286669069, 4502.639788816887, 5042.672226305279, 5081.720505372166, 5162.070827251056, 2043.5477427087555, 2086.4992401823756, 2099.979000210009, 2101.7688054314012, 2113.492761737172, 965.4062751407834, 1066.5840322274319, 1123.0902968595465, 1140.6064907606863, 1163.6799880033059, 17681.0, 19304.420867374, 19814.108365123604, 19939.900300498695, 20094.69857952132, 1010.7169992402139, 1044.4412239452008, 1054.3624495490587, 1055.5672174408455, 1115.2249186815247, 10967.670969870916, 11234.0, 11337.43312834355, 11399.829002564968, 11467.598634047936, 527070.0, 546892.0, 547488.0, 554580.0, 567327.0, 99893.0, 100752.49623751834, 102276.48861755793, 102728.97271027343, 103972.0, 1059.433203236265, 1075.9408232547285, 1123.9438028098562, 1146.9082473402275, 1156.2022204678744, 17691.38080167188, 17936.641267174844, 18010.0, 18140.365087221882, 18150.27398904082, 41359.793201033805, 41576.0, 42256.15487690167, 43626.0, 44156.337654934556, 60386.39613603808, 60684.08973865307, 60693.39306607054, 61541.0, 62530.06204907021, 8034.87947680797, 8282.958585207036, 8682.392232543662, 8753.47479151253, 9024.458532488072, 11876.0, 12899.677508062374, 13507.527236547066, 14063.437462501795, 14415.918806089796, 12126.151169418055, 12365.814512782496, 12402.875971240172, 12433.751324973631, 12587.05597080241, 11944.581939632071, 12088.697782555506, 12178.878211218129, 12509.937450313055, 12546.1844980076, 11457.541698331974, 12158.939205303917, 12190.02479801596, 12614.684632883884, 13134.60596182116, 8885.644574217218, 9143.908560914571, 9204.316919216943, 9228.35401521887, 9274.489903055397, 9461.337706360764, 12543.49826006986, 12587.244765313744, 12595.811062833882, 12652.620421387373], "value": 9547.2800079343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1589.2451085734274, 1624.8375162483749, 1817.6909925312696, 1926.9036548172605, 1953.5116220944765, 8516.957415212915, 9093.363464557484, 9211.401258918166, 9881.901180988198, 9914.256430767704, 9271.768205794842, 9588.664396746115, 9615.471149086798, 9620.518974051305, 9638.566264518096, 2421.1283937782428, 2452.2520631207476, 2463.581191197492, 2465.0139944022353, 2468.7531246875346, 2349.0251545608553, 2375.70303712036, 2399.8200134989856, 2400.4838959623676, 2403.399150212447, 2486.8880900359527, 2493.800495960319, 2495.5757521221344, 2501.7248102708686, 2510.6736124303907, 2298.9310320690324, 2314.0, 2319.93040208794, 2372.4424760181346, 2414.5050264695697, 2345.683332750074, 2424.175780234711, 2435.147698305597, 2471.456279618481, 2480.1443501991785, 9503.097205765442, 9578.90421095794, 9667.758306042335, 9673.22614190863, 9674.177694895941, 5355.464453554652, 5431.891362172734, 5443.2107344434835, 5444.6188766786345, 5444.863878403072, 3231.5314279429585, 3293.4895091260655, 3347.715444187247, 3385.4583266677214, 3391.491276308549, 1086.5056399338282, 1089.9564017439293, 1096.8628921384827, 1106.2643342177441, 1128.9096872250282, 13295.401706923212, 13327.600171994856, 13331.133476324008, 13336.333183340794, 13386.263755493444, 4748.501407352247, 4864.294677271847, 4896.755162241873, 4897.094037603055, 4949.455559888409, 11047.613333533287, 11106.666799996014, 11153.330800152016, 11161.386123763108, 11179.720506987227, 5449.6730196188355, 5516.282883225155, 5523.696196709139, 5529.336479622471, 5699.031164701928, 4474.284114541722, 5010.724410157476, 5011.924821127686, 5153.6907785532985, 5175.06848767218, 4291.313389857608, 4362.367456718822, 4435.822567097344, 4456.420665313553, 4473.060657261946, 1340.9530666426629, 1357.7352416278732, 1364.7543442180304, 1389.4303335632544, 1414.9529348282404, 967.8209531236744, 969.6363863551169, 1003.1122456625939, 1003.7239759066169, 1042.8070806900748, 6180.412860778219, 6273.62358258506, 6364.681765911779, 6372.139761132281, 6458.935410645833, 439.78670344882704, 442.15989619722785, 447.6508323507604, 454.08275283926287, 469.4038571014792, 4255.723377980421, 4304.913901721948, 4317.41714868495, 4320.1143765527995, 4339.370791235253, 11939.164258501994, 12271.57049503263, 12298.754024919452, 12326.938365308117, 12390.194637348544, 11382.203245772716, 11785.292882427082, 12186.390680465942, 12201.755964880831, 12278.938605307096, 8751.256143227769, 8786.25316848075, 8889.377743557889, 8959.059298773534, 8970.686025989058, 6462.709178086903, 6669.866602667822, 6677.966610166918, 6786.0838786765125, 6790.830229244309, 10613.469326533488, 10748.301360411548, 10844.67465976022, 10903.727406814893, 10980.341179529254, 10883.292585981886, 10922.12622990143, 10927.016568508872, 11081.11351091927, 11091.445427728742, 7731.7680469586, 7738.342240909586, 7780.0, 7911.208879112273, 8127.674893004214, 9102.908970910206, 9144.497052662167, 9215.400998935047, 9235.445873247627, 9264.95367523158, 8178.959105204436, 8384.371172162235, 8423.241908228289, 8509.404341696021, 8525.317974562144, 7984.041914970241, 7999.880001800094, 8097.149799270992, 8149.144339844231, 8257.133001034805, 7473.701051957861, 7482.887756683763, 7729.536227826348, 7790.571518566307, 7933.8413231736195, 5411.918821217763, 5501.642393244426, 5628.802991895264, 5629.127485239795, 5675.375708672125, 5414.620976531605, 5425.565954723534, 5465.316835395575, 5493.642913210629, 5546.500814926676], "value": 4837.9822844821365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.81044330839705, 352.8676746220167, 353.77712041413906, 354.9449835275532, 356.0333694020734, 5596.776128954837, 5705.00487244197, 5848.853778655531, 5891.263592050994, 5902.8124812601145, 5697.515711164546, 5754.0, 5786.479216870481, 5792.161840698059, 5811.593188476808, 4545.068345952974, 4553.544645535437, 4554.178328668534, 4558.475775285851, 4567.693314876, 4472.731636101845, 4491.348754430605, 4513.79687914043, 4521.276595744682, 4560.612347950411, 4439.445069366329, 4458.308962110862, 4469.385409535425, 4497.70764900282, 4508.143452743984, 4446.577575130357, 4507.819687212507, 4522.728636281817, 4574.313852922055, 4579.885502862422, 3904.531456225243, 4007.519097708294, 4011.679065674768, 4099.795010249505, 4112.650424713873, 5551.195076713854, 5567.47109024642, 5613.831585052455, 5622.0, 5655.971720141373, 5139.10065738498, 5141.38303403594, 5185.144451165553, 5199.844004679828, 5206.193040078756, 5825.941740582624, 6025.849353766191, 6036.215292012054, 6042.909356359658, 6076.969615151896, 4390.956090439118, 4411.382406463098, 4438.556144385568, 4452.79774460897, 4453.332000199964, 6215.285242197115, 6260.280067792217, 6286.748530058792, 6322.241331040304, 6324.71538780756, 4095.91808163841, 4328.394024836525, 4347.56524347569, 4351.195028919597, 4352.042550638855, 4370.409994650745, 4388.05656783793, 4403.757793321398, 4412.294032954712, 4417.425734654475, 5008.398992120969, 5029.446760856303, 5030.823921162815, 5079.619028572872, 5087.567556757643, 5802.0, 5979.760809567656, 6002.189704389939, 6028.8794224116145, 6046.3651316612, 1563.9296231669603, 1597.7683235930724, 1597.840215978393, 1608.3727346334938, 1609.5251900689325, 999.2905037423366, 1020.9897901020895, 1031.504877658713, 1038.2783965144304, 1044.8850626431085, 5302.28419163408, 5326.36083669962, 5331.546818520469, 5378.489043540857, 5399.514043736004, 5437.510624043776, 5525.502704756591, 5545.223668686387, 5571.272905399339, 5585.273914391103, 5238.768889311009, 5342.2787923630585, 5545.750441230154, 6029.155918171459, 6056.091586262008, 3358.714509266691, 3385.4075536781456, 3394.5587073680263, 3399.8980030599123, 3404.268082362304, 6120.469882529368, 6517.250516190604, 6518.674066296666, 6564.6389448580785, 6584.0, 6321.1782468278825, 6347.873042539123, 6357.427831495188, 6383.585066970632, 6416.903746443807, 6311.873762524724, 6549.443297319686, 6559.704813283413, 6587.670616469253, 6604.787396222223, 6162.630242185483, 6211.850807600608, 6246.0, 6270.561060725706, 6292.811215663537, 6187.133801267916, 6211.378862113933, 6211.689415529115, 6222.253329600477, 6232.470240029648, 6212.0, 6465.967670161619, 6473.8705225896165, 6474.255460622088, 6567.474602031731, 4322.351647252937, 4337.349397590387, 4368.126374725004, 4374.518802931739, 4391.780410979374, 5996.760129594942, 6043.637381757108, 6238.161636455493, 6342.968285158545, 6357.396047375492, 6054.576179667381, 6055.333913269625, 6096.237970253718, 6096.634201947897, 6106.69466526663, 5950.910736339045, 6045.939540604538, 6057.666828324484, 6082.543809214415, 6094.0, 5886.823395298148, 5997.91003134962, 6006.069059295816, 6007.939920600738, 6025.6083354581815, 6103.969480152571, 6141.785037523665, 6181.690915454119, 6186.958303759839, 6198.2871969722255, 5858.8242352729485, 5899.528037756883, 6028.939710603014, 6051.152838602688, 6056.273247210187], "value": 4603.334257492692, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.8636831738604, 815.388458656008, 844.7761343244041, 846.9661213551458, 891.8662200669895, 14657.267136643166, 16538.669226615475, 16551.0, 16607.833921660796, 16610.0, 15319.157446340447, 15562.45531406401, 15658.138802365866, 15699.764503532457, 15748.291326890288, 863.6329559937033, 869.521763030334, 873.1355957601992, 873.4366333714751, 873.4759144513305, 869.9130086991282, 872.2019352292644, 872.7512658892217, 876.8903887014123, 877.4165180155221, 920.4109370003204, 927.5269612497641, 928.2110206324604, 928.5450129436595, 929.8372784762673, 903.4759839293195, 912.8493798523269, 914.085914085914, 914.2822884036, 914.9542522873896, 676.8781619308522, 677.9254282028973, 678.5860625018735, 678.6131904814258, 679.4734081087148, 14846.777298340534, 15073.246337683073, 15098.245087745569, 15115.622109447242, 15119.0, 13985.440582376692, 14012.579622611338, 14039.298035098307, 14139.434422623082, 14205.076670016417, 11921.165518413714, 11924.46339914706, 12089.214201076902, 12241.081918856122, 12527.812082818675, 3980.7611543307203, 3996.3406038003986, 4034.072163402434, 4060.614241647039, 4132.979335103305, 71681.0, 72227.2777272231, 72440.0, 72893.99999999948, 73408.63295683487, 10225.744356391, 10310.32982856112, 10342.793144137075, 10432.530536125892, 10461.215408844215, 20171.193152274038, 20241.79758202399, 20349.796502035086, 20352.79647203509, 20385.898070509553, 8557.957210214034, 8566.571671416405, 8567.828643427096, 8752.737417877473, 8987.820243595092, 4816.975915120472, 4849.539293767087, 4865.878353041202, 4873.171560834667, 4958.479359667183, 3250.723688486458, 3371.713404360657, 3373.8819141329936, 3429.8113603751535, 3436.261203841186, 615.5567991046439, 635.4217661927623, 635.4916067146357, 635.9618422894641, 639.9008153736179, 665.4244078871741, 719.5790462579345, 721.2390927571463, 727.3163226567116, 735.8197241675824, 9513.667021654348, 9520.23838092951, 9595.42427454355, 9603.607476915808, 9619.56711947964, 602.3133627664466, 648.1217949678119, 666.5600703535644, 738.9889151662729, 747.9813004674818, 4675.345451636774, 4764.737939413296, 4775.068861572029, 4804.471508134103, 4830.734309613005, 111992.0, 113923.0, 114520.42739786248, 115426.0, 116933.41533292449, 60856.391436085076, 77109.0, 86388.0, 94960.52519737357, 95078.57382139274, 58339.416605834245, 68911.65544172247, 94598.52700736452, 95100.52449737708, 95714.0, 10298.22763292771, 10420.47897605132, 10713.196510261605, 10757.632305740153, 10859.674209773719, 41460.0, 51450.74274628603, 53911.46088539221, 54456.455435446725, 56408.435915640315, 47408.28887566758, 60861.0, 77280.0, 78189.60905195438, 78861.21138788539, 12807.61577152687, 12885.0, 13152.868471315165, 13212.867871321549, 13451.0, 14689.338979745724, 14691.706165876836, 14788.778168327268, 14954.327055282756, 15574.0, 14219.573412797632, 14220.431182752574, 14222.0, 14930.477433289783, 15258.465953691568, 14586.4894728684, 14695.779563306773, 14794.63013424673, 15018.399264029316, 15056.623584410478, 13363.3986470611, 13473.191608503521, 13651.249181295125, 13710.52013179534, 13735.862641373858, 11445.942770286096, 11454.885451145381, 11494.885051149382, 11524.711882203012, 11685.474153662935, 11882.46528906184, 12204.32876191818, 12344.876551234733, 12360.0, 12589.559365422167], "value": 7668.613549268734, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 110.0, 111.0, 112.0, 110.0, 111.0, 109.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 155.0, 172.0, 126.0, 153.0, 161.0, 126.0, 187.0, 134.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 162.0, 162.0, 163.0, 164.0, 164.0, 162.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 169.0, 76.0, 77.0, 76.0, 75.0, 174.0, 75.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 150.0, 84.0, 84.0, 86.0, 133.0, 85.0, 85.0, 147.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 119.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 151.0, 147.0, 147.0, 147.0, 149.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 98.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 53.0, 53.0, 52.0, 55.0, 55.0, 53.0, 56.0, 53.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 59.0, 58.0, 59.0, 59.0, 61.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 78.0, 78.0, 78.0, 77.0, 77.0, 107.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 130.0, 118.0, 126.0, 133.0, 116.0, 137.0, 124.0, 128.0, 135.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 159.0, 151.0, 155.0, 153.0, 161.0, 154.0, 156.0, 161.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0], "value": 61.9, "unit": "score"}]}]} 18:05:08 INFO - Return code: 0 18:05:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:05:08 ERROR - # TBPL SUCCESS # 18:05:08 INFO - Running post-action listener: _resource_record_post_action 18:05:08 INFO - ##### 18:05:08 INFO - ##### Finished run-tests step (success) 18:05:08 INFO - ##### 18:05:08 INFO - Running post-run listener: _resource_record_post_run 18:05:08 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508825600; Read time: 12; Write time: 387632 18:05:08 INFO - TinderboxPrint: CPU usage
13.4% 18:05:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:05:08 INFO - TinderboxPrint: I/O write bytes / time
508,825,600 / 387,632 18:05:08 INFO - TinderboxPrint: CPU idle
8,202.2 (86.6%) 18:05:08 INFO - TinderboxPrint: CPU user
1,214.1 (12.8%) 18:05:08 INFO - TinderboxPrint: Swap in / out
0 / 0 18:05:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252653568; Read time: 0; Write time: 256904 18:05:08 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249548800; Read time: 12; Write time: 129476 18:05:09 INFO - Running post-run listener: _upload_blobber_files 18:05:09 INFO - Blob upload gear active. 18:05:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:05:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:05:09 INFO - (blobuploader) - INFO - Open directory for files ... 18:05:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:05:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:05:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:10 INFO - (blobuploader) - INFO - Done attempting. 18:05:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:05:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:05:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:11 INFO - (blobuploader) - INFO - Done attempting. 18:05:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:05:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:05:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:15 INFO - (blobuploader) - INFO - Done attempting. 18:05:15 INFO - (blobuploader) - INFO - Iteration through files over. 18:05:15 INFO - Return code: 0 18:05:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:05:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:05:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3568664820348dde6dd4836488b53d4143f5eb5e5f890195a88e5bc890c4d192a34ba6f506ca25833f37ef21647eb1dc029a41fad4863f1015315f683315cd52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7671178d47e6e3d0040924af1e6467ac7d289673625a970e743363e60c07dbebb71255ce3d8ee78b08c3175c822a409f1b6a58e66c4fc8d007216e03d4a3389", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41477229d32a68ee3f9eaa661256a075c6b6ba5fae224c2744c7a57aff8701d3340d8c08f6a4720129bcc4a0011fd0499dc45f34667c537e954045c021043554"} 18:05:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:05:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:05:15 INFO - Contents: 18:05:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3568664820348dde6dd4836488b53d4143f5eb5e5f890195a88e5bc890c4d192a34ba6f506ca25833f37ef21647eb1dc029a41fad4863f1015315f683315cd52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7671178d47e6e3d0040924af1e6467ac7d289673625a970e743363e60c07dbebb71255ce3d8ee78b08c3175c822a409f1b6a58e66c4fc8d007216e03d4a3389", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41477229d32a68ee3f9eaa661256a075c6b6ba5fae224c2744c7a57aff8701d3340d8c08f6a4720129bcc4a0011fd0499dc45f34667c537e954045c021043554"} 18:05:15 INFO - Running post-run listener: copy_logs_to_upload_dir 18:05:15 INFO - Copying logs to upload dir... 18:05:15 INFO - mkdir: /builds/slave/test/build/upload/logs 18:05:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.827003 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-22 18:05:15.254684) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 18:05:15.257937) ========= 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=0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143 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/3568664820348dde6dd4836488b53d4143f5eb5e5f890195a88e5bc890c4d192a34ba6f506ca25833f37ef21647eb1dc029a41fad4863f1015315f683315cd52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7671178d47e6e3d0040924af1e6467ac7d289673625a970e743363e60c07dbebb71255ce3d8ee78b08c3175c822a409f1b6a58e66c4fc8d007216e03d4a3389", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41477229d32a68ee3f9eaa661256a075c6b6ba5fae224c2744c7a57aff8701d3340d8c08f6a4720129bcc4a0011fd0499dc45f34667c537e954045c021043554"} build_url:https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/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/3568664820348dde6dd4836488b53d4143f5eb5e5f890195a88e5bc890c4d192a34ba6f506ca25833f37ef21647eb1dc029a41fad4863f1015315f683315cd52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7671178d47e6e3d0040924af1e6467ac7d289673625a970e743363e60c07dbebb71255ce3d8ee78b08c3175c822a409f1b6a58e66c4fc8d007216e03d4a3389", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41477229d32a68ee3f9eaa661256a075c6b6ba5fae224c2744c7a57aff8701d3340d8c08f6a4720129bcc4a0011fd0499dc45f34667c537e954045c021043554"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 18:05:15.282955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 18:05:15.283273) ========= 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=0333a256a5e4f052382dd180000001b1-1466642138.168778-957280143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 18:05:15.368834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 18:05:15.369331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 18:05:15.369638) ========= ========= Total master_lag: 0.20 =========