builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1465490698.83 results: success (0) buildid: 20160609064045 builduid: 4aff9b6ecc1a45c384cd3d8882e8cd78 revision: f8e3b81a79f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 09:44:58.830343) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 09:44:58.831188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 09:44:58.831656) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 09:44:58.844670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:44:58.845015) ========= 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=32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 09:44:58-- 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% 27.1M=0s 2016-06-09 09:44:59 (27.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117290 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:44:58.974939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:44:58.975343) ========= 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=32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020512 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:44:59.026670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 09:44:59.027175) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8e3b81a79f4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8e3b81a79f4 --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=32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 09:44:59,132 Setting DEBUG logging. 2016-06-09 09:44:59,132 attempt 1/10 2016-06-09 09:44:59,132 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8e3b81a79f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 09:45:00,555 unpacking tar archive at: mozilla-central-f8e3b81a79f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.765182 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 09:45:00.807977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 09:45:00.808504) ========= script_repo_revision: f8e3b81a79f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 09:45:00.809089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 09:45:00.809571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 09:45:00.821875) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-09 09:45:00.822455) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:45:01 INFO - MultiFileLogger online at 20160609 09:45:01 in /builds/slave/test 09:45:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:45:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:45:01 INFO - {'append_to_log': False, 09:45:01 INFO - 'base_work_dir': '/builds/slave/test', 09:45:01 INFO - 'blob_upload_branch': 'Firefox', 09:45:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:45:01 INFO - 'branch': 'Firefox', 09:45:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:45:01 INFO - 'config_files': ('talos/linux_config.py',), 09:45:01 INFO - 'default_actions': ('clobber', 09:45:01 INFO - 'read-buildbot-config', 09:45:01 INFO - 'download-and-extract', 09:45:01 INFO - 'populate-webroot', 09:45:01 INFO - 'create-virtualenv', 09:45:01 INFO - 'install', 09:45:01 INFO - 'run-tests'), 09:45:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:45:01 INFO - 'download_minidump_stackwalk': True, 09:45:01 INFO - 'download_symbols': 'ondemand', 09:45:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:45:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:45:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:45:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:45:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:45:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:45:01 INFO - 'installer_path': 'installer.exe', 09:45:01 INFO - 'log_level': 'info', 09:45:01 INFO - 'log_name': 'talos', 09:45:01 INFO - 'log_to_console': True, 09:45:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:45:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:45:01 INFO - 'opt_config_files': (), 09:45:01 INFO - 'pip_index': False, 09:45:01 INFO - 'sps_profile': False, 09:45:01 INFO - 'sps_profile_interval': 0, 09:45:01 INFO - 'suite': 'dromaeojs-e10s', 09:45:01 INFO - 'system_bits': '32', 09:45:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:45:01 INFO - 'title': 'talos-linux64-ix-008', 09:45:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:45:01 INFO - 'use_talos_json': True, 09:45:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:45:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:45:01 INFO - 'work_dir': 'build'} 09:45:01 INFO - ##### 09:45:01 INFO - ##### Running clobber step. 09:45:01 INFO - ##### 09:45:01 INFO - Running pre-action listener: _resource_record_pre_action 09:45:01 INFO - Running main action method: clobber 09:45:01 INFO - rmtree: /builds/slave/test/build 09:45:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:01 INFO - Running post-action listener: _resource_record_post_action 09:45:01 INFO - ##### 09:45:01 INFO - ##### Finished clobber step (success) 09:45:01 INFO - ##### 09:45:01 INFO - ##### 09:45:01 INFO - ##### Running read-buildbot-config step. 09:45:01 INFO - ##### 09:45:01 INFO - Running pre-action listener: _resource_record_pre_action 09:45:01 INFO - Running main action method: read_buildbot_config 09:45:01 INFO - Using buildbot properties: 09:45:01 INFO - { 09:45:01 INFO - "project": "", 09:45:01 INFO - "product": "firefox", 09:45:01 INFO - "script_repo_revision": "production", 09:45:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:45:01 INFO - "repository": "", 09:45:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:45:01 INFO - "buildid": "20160609064045", 09:45:01 INFO - "stage_platform": "linux64-pgo", 09:45:01 INFO - "basedir": "/builds/slave/test", 09:45:01 INFO - "nightly_build": "True", 09:45:01 INFO - "buildnumber": 64, 09:45:01 INFO - "slavename": "talos-linux64-ix-008", 09:45:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:45:01 INFO - "platform": "ubuntu64_hw", 09:45:01 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:45:01 INFO - "branch": "mozilla-central", 09:45:01 INFO - "repo_path": "mozilla-central", 09:45:01 INFO - "revision": "f8e3b81a79f4", 09:45:01 INFO - "pgo_build": "True", 09:45:01 INFO - "builduid": "4aff9b6ecc1a45c384cd3d8882e8cd78", 09:45:01 INFO - "slavebuilddir": "test" 09:45:01 INFO - } 09:45:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:45:01 INFO - Running post-action listener: _resource_record_post_action 09:45:01 INFO - ##### 09:45:01 INFO - ##### Finished read-buildbot-config step (success) 09:45:01 INFO - ##### 09:45:01 INFO - ##### 09:45:01 INFO - ##### Running download-and-extract step. 09:45:01 INFO - ##### 09:45:01 INFO - Running pre-action listener: _resource_record_pre_action 09:45:01 INFO - Running main action method: download_and_extract 09:45:01 INFO - mkdir: /builds/slave/test/build/tests 09:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:01 INFO - https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:45:02 INFO - Downloaded 1361 bytes. 09:45:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:02 INFO - Using the following test package requirements: 09:45:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:45:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:45:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:02 INFO - u'jsshell-linux-x86_64.zip'], 09:45:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:45:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:45:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:45:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:45:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:45:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09: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')]} 09:45:02 INFO - https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:45:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:45:03 INFO - Downloaded 24452072 bytes. 09:45:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:45:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:45:05 INFO - Return code: 0 09:45:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:45:05 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')]} 09:45:05 INFO - https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:45:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:45:06 INFO - Downloaded 24452072 bytes. 09:45:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:45:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:45:07 INFO - Return code: 0 09: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')]} 09:45:07 INFO - https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:45:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:45:08 INFO - Downloaded 10833377 bytes. 09:45:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:45:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:45:08 INFO - Return code: 0 09:45:08 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')]} 09:45:08 INFO - https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:45:10 INFO - Downloaded 59341553 bytes. 09:45:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:10 INFO - mkdir: /builds/slave/test/properties 09:45:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:10 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:10 INFO - Contents: 09:45:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:11 INFO - Running post-action listener: _resource_record_post_action 09:45:11 INFO - Running post-action listener: set_extra_try_arguments 09:45:11 INFO - ##### 09:45:11 INFO - ##### Finished download-and-extract step (success) 09:45:11 INFO - ##### 09:45:11 INFO - ##### 09:45:11 INFO - ##### Running populate-webroot step. 09:45:11 INFO - ##### 09:45:11 INFO - Running pre-action listener: _resource_record_pre_action 09:45:11 INFO - Running main action method: populate_webroot 09:45:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:11 INFO - '--tppagecycles', 09:45:11 INFO - '7'], 09:45:11 INFO - 'tests': ['tsvgm']}}, 09:45:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['damp', 'tps']}, 09:45:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'tests': ['damp', 'tps']}, 09:45:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['dromaeo_dom']}, 09:45:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['a11yr', 09:45:11 INFO - 'ts_paint', 09:45:11 INFO - 'tpaint', 09:45:11 INFO - 'sessionrestore', 09:45:11 INFO - 'sessionrestore_no_auto_restore', 09:45:11 INFO - 'tabpaint']}, 09:45:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['tsvgx', 09:45:11 INFO - 'tsvgr_opacity', 09:45:11 INFO - 'tart', 09:45:11 INFO - 'tscrollx', 09:45:11 INFO - 'cart']}, 09:45:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:11 INFO - 'tsvgr_opacity', 09:45:11 INFO - 'tart', 09:45:11 INFO - 'tscrollx', 09:45:11 INFO - 'cart']}, 09:45:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'talos_options': ['--disable-e10s'], 09:45:11 INFO - 'tests': ['tp5o']}, 09:45:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'tests': ['tp5o']}, 09:45:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'talos_options': ['--disable-e10s', 09:45:11 INFO - '--xperf_path', 09:45:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:11 INFO - 'tests': ['tp5n']}, 09:45:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:11 INFO - 'talos_options': ['--xperf_path', 09:45:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:11 INFO - 'tests': ['tp5n']}}, 09:45:11 INFO - 'talos.zip': {'path': '', 09:45:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:11 INFO - Running post-action listener: _resource_record_post_action 09:45:11 INFO - ##### 09:45:11 INFO - ##### Finished populate-webroot step (success) 09:45:11 INFO - ##### 09:45:11 INFO - ##### 09:45:11 INFO - ##### Running create-virtualenv step. 09:45:11 INFO - ##### 09:45:11 INFO - Running pre-action listener: _resource_record_pre_action 09:45:11 INFO - Running main action method: create_virtualenv 09:45:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:11 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 09:45:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:11 INFO - Using real prefix '/usr' 09:45:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:11 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:13 INFO - Installing pip.................done. 09:45:13 INFO - Return code: 0 09:45:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:13 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 0x7f5d7ff1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2634190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, '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': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', '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 09:45:13 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 09:45:13 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 09:45:13 INFO - Using env: {'DISPLAY': ':0', 09:45:13 INFO - 'HOME': '/home/cltbld', 09:45:13 INFO - 'LANG': 'en_US.UTF-8', 09:45:13 INFO - 'LANGUAGE': 'en_US:en', 09:45:13 INFO - 'LOGNAME': 'cltbld', 09:45:13 INFO - 'MAIL': '/var/mail/cltbld', 09:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:13 INFO - 'MOZ_NO_REMOTE': '1', 09:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:13 INFO - 'NO_EM_RESTART': '1', 09:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:13 INFO - 'PWD': '/builds/slave/test', 09:45:13 INFO - 'SHELL': '/bin/bash', 09:45:13 INFO - 'SHLVL': '1', 09:45:13 INFO - 'TERM': 'linux', 09:45:13 INFO - 'TMOUT': '86400', 09:45:13 INFO - 'USER': 'cltbld', 09:45:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:13 INFO - '_': '/tools/buildbot/bin/python'} 09:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:13 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 09:45:13 INFO - Cleaning up... 09:45:13 INFO - Return code: 0 09:45:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:13 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 0x7f5d7ff1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2634190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, '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': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', '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 09:45:13 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 09:45:13 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 09:45:13 INFO - Using env: {'DISPLAY': ':0', 09:45:13 INFO - 'HOME': '/home/cltbld', 09:45:13 INFO - 'LANG': 'en_US.UTF-8', 09:45:13 INFO - 'LANGUAGE': 'en_US:en', 09:45:13 INFO - 'LOGNAME': 'cltbld', 09:45:13 INFO - 'MAIL': '/var/mail/cltbld', 09:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:13 INFO - 'MOZ_NO_REMOTE': '1', 09:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:13 INFO - 'NO_EM_RESTART': '1', 09:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:13 INFO - 'PWD': '/builds/slave/test', 09:45:13 INFO - 'SHELL': '/bin/bash', 09:45:13 INFO - 'SHLVL': '1', 09:45:13 INFO - 'TERM': 'linux', 09:45:13 INFO - 'TMOUT': '86400', 09:45:13 INFO - 'USER': 'cltbld', 09:45:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:13 INFO - '_': '/tools/buildbot/bin/python'} 09:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:14 INFO - Downloading/unpacking psutil>=3.1.1 09:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:16 INFO - Installing collected packages: psutil 09:45:16 INFO - Running setup.py install for psutil 09:45:16 INFO - building 'psutil._psutil_linux' extension 09:45:16 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 09:45:16 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 09:45:16 INFO - building 'psutil._psutil_posix' extension 09:45:16 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 09:45:16 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 09:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:16 INFO - Successfully installed psutil 09:45:16 INFO - Cleaning up... 09:45:16 INFO - Return code: 0 09:45:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:45:16 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')]} 09:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:16 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')]} 09:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:16 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 0x7f5d7ff1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2634190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, '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': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', '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 09:45:16 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 09:45:16 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 09:45:16 INFO - Using env: {'DISPLAY': ':0', 09:45:16 INFO - 'HOME': '/home/cltbld', 09:45:16 INFO - 'LANG': 'en_US.UTF-8', 09:45:16 INFO - 'LANGUAGE': 'en_US:en', 09:45:16 INFO - 'LOGNAME': 'cltbld', 09:45:16 INFO - 'MAIL': '/var/mail/cltbld', 09:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:16 INFO - 'MOZ_NO_REMOTE': '1', 09:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:16 INFO - 'NO_EM_RESTART': '1', 09:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:16 INFO - 'PWD': '/builds/slave/test', 09:45:16 INFO - 'SHELL': '/bin/bash', 09:45:16 INFO - 'SHLVL': '1', 09:45:16 INFO - 'TERM': 'linux', 09:45:16 INFO - 'TMOUT': '86400', 09:45:16 INFO - 'USER': 'cltbld', 09:45:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:16 INFO - '_': '/tools/buildbot/bin/python'} 09:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:45:18 INFO - Installing collected packages: mozsystemmonitor 09:45:18 INFO - Running setup.py install for mozsystemmonitor 09:45:18 INFO - Successfully installed mozsystemmonitor 09:45:18 INFO - Cleaning up... 09:45:19 INFO - Return code: 0 09:45:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:45:19 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')]} 09:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:19 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')]} 09:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:19 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 0x7f5d7ff1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2634190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, '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': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', '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 09:45:19 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 09:45:19 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 09:45:19 INFO - Using env: {'DISPLAY': ':0', 09:45:19 INFO - 'HOME': '/home/cltbld', 09:45:19 INFO - 'LANG': 'en_US.UTF-8', 09:45:19 INFO - 'LANGUAGE': 'en_US:en', 09:45:19 INFO - 'LOGNAME': 'cltbld', 09:45:19 INFO - 'MAIL': '/var/mail/cltbld', 09:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:19 INFO - 'MOZ_NO_REMOTE': '1', 09:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:19 INFO - 'NO_EM_RESTART': '1', 09:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:19 INFO - 'PWD': '/builds/slave/test', 09:45:19 INFO - 'SHELL': '/bin/bash', 09:45:19 INFO - 'SHLVL': '1', 09:45:19 INFO - 'TERM': 'linux', 09:45:19 INFO - 'TMOUT': '86400', 09:45:19 INFO - 'USER': 'cltbld', 09:45:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:19 INFO - '_': '/tools/buildbot/bin/python'} 09:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:19 INFO - Downloading/unpacking jsonschema==2.5.1 09:45:19 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 09:45:19 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 09:45:19 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 09:45:19 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 09:45:19 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 09:45:19 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 09:45:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:45:21 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 09:45:21 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 09:45:21 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 09:45:21 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 09:45:21 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 09:45:21 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 09:45:21 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:21 INFO - warning: no files found matching '*.txt' 09:45:21 INFO - no previously-included directories found matching 'build' 09:45:21 INFO - no previously-included directories found matching 'dist' 09:45:21 INFO - no previously-included directories found matching '.git*' 09:45:21 INFO - Installing collected packages: jsonschema, functools32 09:45:21 INFO - Running setup.py install for functools32 09:45:21 INFO - warning: no files found matching '*.txt' 09:45:21 INFO - no previously-included directories found matching 'build' 09:45:21 INFO - no previously-included directories found matching 'dist' 09:45:21 INFO - no previously-included directories found matching '.git*' 09:45:21 INFO - Successfully installed jsonschema functools32 09:45:21 INFO - Cleaning up... 09:45:21 INFO - Return code: 0 09:45:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:21 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 0x7f5d7ff1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2634190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, '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': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', '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 09:45:21 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 09:45:21 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 09:45:21 INFO - Using env: {'DISPLAY': ':0', 09:45:21 INFO - 'HOME': '/home/cltbld', 09:45:21 INFO - 'LANG': 'en_US.UTF-8', 09:45:21 INFO - 'LANGUAGE': 'en_US:en', 09:45:21 INFO - 'LOGNAME': 'cltbld', 09:45:21 INFO - 'MAIL': '/var/mail/cltbld', 09:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:21 INFO - 'MOZ_NO_REMOTE': '1', 09:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:21 INFO - 'NO_EM_RESTART': '1', 09:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:21 INFO - 'PWD': '/builds/slave/test', 09:45:21 INFO - 'SHELL': '/bin/bash', 09:45:21 INFO - 'SHLVL': '1', 09:45:21 INFO - 'TERM': 'linux', 09:45:21 INFO - 'TMOUT': '86400', 09:45:21 INFO - 'USER': 'cltbld', 09:45:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:21 INFO - '_': '/tools/buildbot/bin/python'} 09:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:21 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:21 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 09:45:21 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 09:45:21 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 09:45:21 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 09:45:21 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 09:45:21 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 09:45:23 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:23 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 09:45:23 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 09:45:23 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 09:45:23 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 09:45:23 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 09:45:23 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 09:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 INFO - Downloading docopt-0.6.1.tar.gz 09:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:24 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:24 INFO - Running setup.py install for blobuploader 09:45:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:24 INFO - Running setup.py install for requests 09:45:24 INFO - Running setup.py install for docopt 09:45:24 INFO - Successfully installed blobuploader requests docopt 09:45:24 INFO - Cleaning up... 09:45:25 INFO - Return code: 0 09:45:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:25 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 0x7f5d7ff1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2634190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, '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': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', '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 09:45:25 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 09:45:25 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 09:45:25 INFO - Using env: {'DISPLAY': ':0', 09:45:25 INFO - 'HOME': '/home/cltbld', 09:45:25 INFO - 'LANG': 'en_US.UTF-8', 09:45:25 INFO - 'LANGUAGE': 'en_US:en', 09:45:25 INFO - 'LOGNAME': 'cltbld', 09:45:25 INFO - 'MAIL': '/var/mail/cltbld', 09:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:25 INFO - 'MOZ_NO_REMOTE': '1', 09:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:25 INFO - 'NO_EM_RESTART': '1', 09:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:25 INFO - 'PWD': '/builds/slave/test', 09:45:25 INFO - 'SHELL': '/bin/bash', 09:45:25 INFO - 'SHLVL': '1', 09:45:25 INFO - 'TERM': 'linux', 09:45:25 INFO - 'TMOUT': '86400', 09:45:25 INFO - 'USER': 'cltbld', 09:45:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:25 INFO - '_': '/tools/buildbot/bin/python'} 09:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:25 INFO - Running setup.py (path:/tmp/pip-X43Ofj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:25 INFO - Running setup.py (path:/tmp/pip-8RUL7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:25 INFO - Running setup.py (path:/tmp/pip-ZKrrSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:25 INFO - Running setup.py (path:/tmp/pip-7UeIf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:25 INFO - Running setup.py (path:/tmp/pip-XiqqCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:25 INFO - Running setup.py (path:/tmp/pip-3XqDfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:25 INFO - Running setup.py (path:/tmp/pip-jBTBLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:25 INFO - Running setup.py (path:/tmp/pip-VdMLse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:25 INFO - Running setup.py (path:/tmp/pip-v2cBkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:25 INFO - Running setup.py (path:/tmp/pip-10HM8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:25 INFO - Running setup.py (path:/tmp/pip-HWByHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:26 INFO - Running setup.py (path:/tmp/pip-MZhq01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:26 INFO - Running setup.py (path:/tmp/pip-NI6YRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:26 INFO - Running setup.py (path:/tmp/pip-CRQqm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:26 INFO - Running setup.py (path:/tmp/pip-O4RruY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:26 INFO - Running setup.py (path:/tmp/pip-h62hXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:26 INFO - Running setup.py (path:/tmp/pip-fmeQMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:26 INFO - Running setup.py install for manifestparser 09:45:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:26 INFO - Running setup.py install for mozcrash 09:45:26 INFO - Running setup.py install for mozdebug 09:45:26 INFO - Running setup.py install for mozdevice 09:45:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:26 INFO - Running setup.py install for mozfile 09:45:27 INFO - Running setup.py install for mozhttpd 09:45:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozinfo 09:45:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozInstall 09:45:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozleak 09:45:27 INFO - Running setup.py install for mozlog 09:45:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for moznetwork 09:45:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozprocess 09:45:27 INFO - Running setup.py install for mozprofile 09:45:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozrunner 09:45:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozscreenshot 09:45:28 INFO - Running setup.py install for moztest 09:45:28 INFO - Running setup.py install for mozversion 09:45:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:28 INFO - Cleaning up... 09:45:28 INFO - Return code: 0 09:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:28 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 0x7f5d7ff1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2634190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, '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': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', '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 09:45:28 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 09:45:28 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 09:45:28 INFO - Using env: {'DISPLAY': ':0', 09:45:28 INFO - 'HOME': '/home/cltbld', 09:45:28 INFO - 'LANG': 'en_US.UTF-8', 09:45:28 INFO - 'LANGUAGE': 'en_US:en', 09:45:28 INFO - 'LOGNAME': 'cltbld', 09:45:28 INFO - 'MAIL': '/var/mail/cltbld', 09:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:28 INFO - 'MOZ_NO_REMOTE': '1', 09:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:28 INFO - 'NO_EM_RESTART': '1', 09:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:28 INFO - 'PWD': '/builds/slave/test', 09:45:28 INFO - 'SHELL': '/bin/bash', 09:45:28 INFO - 'SHLVL': '1', 09:45:28 INFO - 'TERM': 'linux', 09:45:28 INFO - 'TMOUT': '86400', 09:45:28 INFO - 'USER': 'cltbld', 09:45:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:28 INFO - '_': '/tools/buildbot/bin/python'} 09:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:28 INFO - Running setup.py (path:/tmp/pip-wQEuqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:28 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)) 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:28 INFO - Running setup.py (path:/tmp/pip-PVez2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:28 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)) 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:28 INFO - Running setup.py (path:/tmp/pip-5nvgJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:28 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)) 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:28 INFO - Running setup.py (path:/tmp/pip-hjMDgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:28 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)) 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:28 INFO - Running setup.py (path:/tmp/pip-9m8UrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:28 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)) 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:28 INFO - Running setup.py (path:/tmp/pip-LeWSHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:28 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)) 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:28 INFO - Running setup.py (path:/tmp/pip-t9_LjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:29 INFO - Running setup.py (path:/tmp/pip-6paATL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:29 INFO - Running setup.py (path:/tmp/pip-md8fhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:29 INFO - Running setup.py (path:/tmp/pip-1FMT75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:29 INFO - Running setup.py (path:/tmp/pip-ow_wmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:29 INFO - Running setup.py (path:/tmp/pip-Tk2ZLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:29 INFO - Running setup.py (path:/tmp/pip-vzPXV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:29 INFO - Running setup.py (path:/tmp/pip-slYO_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:29 INFO - Running setup.py (path:/tmp/pip-gm8iAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:29 INFO - Running setup.py (path:/tmp/pip-6YyRwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:29 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)) 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:29 INFO - Running setup.py (path:/tmp/pip-rO34jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:29 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)) 09:45:29 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)) 09:45:29 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)) 09:45:29 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)) 09:45:29 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)) 09:45:29 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)) 09:45:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:29 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 09:45:29 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 09:45:29 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 09:45:29 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 09:45:29 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 09:45:29 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 09:45:31 INFO - Downloading blessings-1.6.tar.gz 09:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:31 INFO - Installing collected packages: blessings 09:45:31 INFO - Running setup.py install for blessings 09:45:31 INFO - Successfully installed blessings 09:45:31 INFO - Cleaning up... 09:45:31 INFO - Return code: 0 09:45:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:32 INFO - Reading from file tmpfile_stdout 09:45:32 INFO - Current package versions: 09:45:32 INFO - argparse == 1.2.1 09:45:32 INFO - blessings == 1.6 09:45:32 INFO - blobuploader == 1.2.4 09:45:32 INFO - docopt == 0.6.1 09:45:32 INFO - functools32 == 3.2.3-2 09:45:32 INFO - jsonschema == 2.5.1 09:45:32 INFO - manifestparser == 1.1 09:45:32 INFO - mozInstall == 1.12 09:45:32 INFO - mozcrash == 0.17 09:45:32 INFO - mozdebug == 0.1 09:45:32 INFO - mozdevice == 0.48 09:45:32 INFO - mozfile == 1.2 09:45:32 INFO - mozhttpd == 0.7 09:45:32 INFO - mozinfo == 0.9 09:45:32 INFO - mozleak == 0.1 09:45:32 INFO - mozlog == 3.2 09:45:32 INFO - moznetwork == 0.27 09:45:32 INFO - mozprocess == 0.22 09:45:32 INFO - mozprofile == 0.28 09:45:32 INFO - mozrunner == 6.11 09:45:32 INFO - mozscreenshot == 0.1 09:45:32 INFO - mozsystemmonitor == 0.3 09:45:32 INFO - moztest == 0.7 09:45:32 INFO - mozversion == 1.4 09:45:32 INFO - psutil == 3.1.1 09:45:32 INFO - requests == 1.2.3 09:45:32 INFO - wsgiref == 0.1.2 09:45:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:32 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')]} 09:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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')]} 09:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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 0x7f5d7ff1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2634190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, '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': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', '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 09:45:32 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 09:45:32 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 09:45:32 INFO - Using env: {'DISPLAY': ':0', 09:45:32 INFO - 'HOME': '/home/cltbld', 09:45:32 INFO - 'LANG': 'en_US.UTF-8', 09:45:32 INFO - 'LANGUAGE': 'en_US:en', 09:45:32 INFO - 'LOGNAME': 'cltbld', 09:45:32 INFO - 'MAIL': '/var/mail/cltbld', 09:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:32 INFO - 'MOZ_NO_REMOTE': '1', 09:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:32 INFO - 'NO_EM_RESTART': '1', 09:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:32 INFO - 'PWD': '/builds/slave/test', 09:45:32 INFO - 'SHELL': '/bin/bash', 09:45:32 INFO - 'SHLVL': '1', 09:45:32 INFO - 'TERM': 'linux', 09:45:32 INFO - 'TMOUT': '86400', 09:45:32 INFO - 'USER': 'cltbld', 09:45:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:32 INFO - '_': '/tools/buildbot/bin/python'} 09:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 INFO - Cleaning up... 09:45:32 INFO - Return code: 0 09:45:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45:32 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')]} 09:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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')]} 09:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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 0x7f5d7ff1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2634190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, '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': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', '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 09:45:32 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 09:45:32 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 09:45:32 INFO - Using env: {'DISPLAY': ':0', 09:45:32 INFO - 'HOME': '/home/cltbld', 09:45:32 INFO - 'LANG': 'en_US.UTF-8', 09:45:32 INFO - 'LANGUAGE': 'en_US:en', 09:45:32 INFO - 'LOGNAME': 'cltbld', 09:45:32 INFO - 'MAIL': '/var/mail/cltbld', 09:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:32 INFO - 'MOZ_NO_REMOTE': '1', 09:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:32 INFO - 'NO_EM_RESTART': '1', 09:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:32 INFO - 'PWD': '/builds/slave/test', 09:45:32 INFO - 'SHELL': '/bin/bash', 09:45:32 INFO - 'SHLVL': '1', 09:45:32 INFO - 'TERM': 'linux', 09:45:32 INFO - 'TMOUT': '86400', 09:45:32 INFO - 'USER': 'cltbld', 09:45:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:32 INFO - '_': '/tools/buildbot/bin/python'} 09:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:45:32 INFO - Cleaning up... 09:45:32 INFO - Return code: 0 09:45:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:45:32 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')]} 09:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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')]} 09:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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 0x7f5d7ff1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2634190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, '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': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', '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 09:45:32 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 09:45:32 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 09:45:32 INFO - Using env: {'DISPLAY': ':0', 09:45:32 INFO - 'HOME': '/home/cltbld', 09:45:32 INFO - 'LANG': 'en_US.UTF-8', 09:45:32 INFO - 'LANGUAGE': 'en_US:en', 09:45:32 INFO - 'LOGNAME': 'cltbld', 09:45:32 INFO - 'MAIL': '/var/mail/cltbld', 09:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:32 INFO - 'MOZ_NO_REMOTE': '1', 09:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:32 INFO - 'NO_EM_RESTART': '1', 09:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:32 INFO - 'PWD': '/builds/slave/test', 09:45:32 INFO - 'SHELL': '/bin/bash', 09:45:32 INFO - 'SHLVL': '1', 09:45:32 INFO - 'TERM': 'linux', 09:45:32 INFO - 'TMOUT': '86400', 09:45:32 INFO - 'USER': 'cltbld', 09:45:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:32 INFO - '_': '/tools/buildbot/bin/python'} 09:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:32 INFO - Downloading/unpacking flake8 09:45:32 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 09:45:32 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 09:45:32 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 09:45:32 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 09:45:32 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 09:45:32 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 09:45:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:45:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:45:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:45:35 INFO - no previously-included directories found matching 'docs/_build' 09:45:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:45:35 INFO - Running setup.py install for pep8 09:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:45:35 INFO - no previously-included directories found matching 'docs/_build' 09:45:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:45:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:45:35 INFO - Cleaning up... 09:45:35 INFO - Return code: 0 09:45:35 INFO - Running post-action listener: _resource_record_post_action 09:45:35 INFO - Running post-action listener: _start_resource_monitoring 09:45:35 INFO - Starting resource monitoring. 09:45:35 INFO - ##### 09:45:35 INFO - ##### Finished create-virtualenv step (success) 09:45:35 INFO - ##### 09:45:35 INFO - ##### 09:45:35 INFO - ##### Running install step. 09:45:35 INFO - ##### 09:45:35 INFO - Running pre-action listener: _resource_record_pre_action 09:45:35 INFO - Running main action method: install 09:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:35 INFO - Reading from file tmpfile_stdout 09:45:35 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:35 INFO - Reading from file tmpfile_stdout 09:45:35 INFO - Output received: 09:45:35 INFO - Usage: mozinstall [options] installer 09:45:35 INFO - Options: 09:45:35 INFO - -h, --help show this help message and exit 09:45:35 INFO - -d DEST, --destination=DEST 09:45:35 INFO - Directory to install application into. [default: 09:45:35 INFO - "/builds/slave/test"] 09:45:35 INFO - --app=APP Application being installed. [default: firefox] 09:45:35 INFO - mkdir: /builds/slave/test/build/application 09:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:45:52 INFO - Reading from file tmpfile_stdout 09:45:52 INFO - Output received: 09:45:52 INFO - /builds/slave/test/build/application/firefox/firefox 09:45:52 INFO - Running post-action listener: _resource_record_post_action 09:45:52 INFO - ##### 09:45:52 INFO - ##### Finished install step (success) 09:45:52 INFO - ##### 09:45:52 INFO - ##### 09:45:52 INFO - ##### Running run-tests step. 09:45:52 INFO - ##### 09:45:52 INFO - Running pre-action listener: _resource_record_pre_action 09:45:52 INFO - Running main action method: run_tests 09:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:45:52 INFO - Python 2.7.3 09:45:52 INFO - Return code: 0 09:45:52 INFO - grabbing minidump binary from tooltool 09:45: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')]} 09:45:52 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 0x26c6110>, '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 0x2632230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26326c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:45:52 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 09:45:52 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 09:45:52 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 09:45:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:45:52 INFO - Return code: 0 09:45:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:45:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:45:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:45:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:45:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:45:53 INFO - Return code: 0 09:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 09:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 09:45:53 INFO - Using env: {'DISPLAY': ':0', 09:45:53 INFO - 'HOME': '/home/cltbld', 09:45:53 INFO - 'LANG': 'en_US.UTF-8', 09:45:53 INFO - 'LANGUAGE': 'en_US:en', 09:45:53 INFO - 'LOGNAME': 'cltbld', 09:45:53 INFO - 'MAIL': '/var/mail/cltbld', 09:45:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:45:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:53 INFO - 'MOZ_NO_REMOTE': '1', 09:45:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:53 INFO - 'NO_EM_RESTART': '1', 09:45:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:53 INFO - 'PWD': '/builds/slave/test', 09:45:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:45:53 INFO - 'SHELL': '/bin/bash', 09:45:53 INFO - 'SHLVL': '1', 09:45:53 INFO - 'TERM': 'linux', 09:45:53 INFO - 'TMOUT': '86400', 09:45:53 INFO - 'USER': 'cltbld', 09:45:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182', 09:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:53 INFO - '_': '/tools/buildbot/bin/python'} 09:45:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 09:45:54 INFO - mozversion application_buildid: 20160609064045 09:45:54 INFO - mozversion application_changeset: f8e3b81a79f45ef8647c98281a9a00d1ddb28b73 09:45:54 INFO - mozversion application_display_name: Nightly 09:45:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:45:54 INFO - mozversion application_name: Firefox 09:45:54 INFO - mozversion application_remotingname: firefox 09:45:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:45:54 INFO - mozversion application_vendor: Mozilla 09:45:54 INFO - mozversion application_version: 50.0a1 09:45:54 INFO - mozversion platform_buildid: 20160609064045 09:45:54 INFO - mozversion platform_changeset: f8e3b81a79f45ef8647c98281a9a00d1ddb28b73 09:45:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:45:54 INFO - mozversion platform_version: 50.0a1 09:45:54 INFO - using testdate: 1465490754 09:45:54 INFO - actual date: 1465490754 09:45:54 INFO - starting webserver on 'localhost:59364' 09:45:54 INFO - SUITE-START | Running 2 tests 09:45:54 INFO - TEST-START | dromaeo_css 09:45:54 INFO - operating with platform_type : linux_ 09:45:54 INFO - Initialising browser for dromaeo_css test... 09:45:54 INFO - TEST-INFO | started process 17085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOXpEJY/profile http://localhost:59364/getInfo.html) 09:45:58 INFO - PROCESS | 17085 | __metrics Screen width/height:1600/1200 09:45:58 INFO - PROCESS | 17085 | colorDepth:24 09:45:58 INFO - PROCESS | 17085 | Browser inner width/height: 1024/697 09:45:58 INFO - PROCESS | 17085 | __metrics 09:45:59 ERROR - PROCESS | 17085 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:46:00 INFO - TEST-INFO | 17085: exit 0 09:46:00 INFO - Browser initialized. 09:46:00 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:00 INFO - TEST-INFO | started process 17202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOXpEJY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:12 INFO - PROCESS | 17202 | RSS: Main: 184492032 09:46:12 INFO - PROCESS | 17202 | 09:47:01 INFO - PROCESS | 17202 | 1465490821956 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] 09:49:09 INFO - PROCESS | 17202 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59364/tests/dromaeo/cssquery-ext.html) 09:49:10 INFO - PROCESS | 17202 | RSS: Main: 187445248 09:49:10 INFO - PROCESS | 17202 | 09:52:12 INFO - PROCESS | 17202 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-ext.html (next: http://localhost:59364/tests/dromaeo/cssquery-jquery.html) 09:52:13 INFO - PROCESS | 17202 | RSS: Main: 186261504 09:52:13 INFO - PROCESS | 17202 | 09:55:15 INFO - PROCESS | 17202 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59364/tests/dromaeo/cssquery-mootools.html) 09:55:16 INFO - PROCESS | 17202 | RSS: Main: 187994112 09:55:16 INFO - PROCESS | 17202 | 09:58:17 INFO - PROCESS | 17202 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59364/tests/dromaeo/cssquery-prototype.html) 09:58:18 INFO - PROCESS | 17202 | RSS: Main: 184983552 09:58:18 INFO - PROCESS | 17202 | 10:01:20 INFO - PROCESS | 17202 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59364/tests/dromaeo/cssquery-yui.html) 10:01:21 INFO - PROCESS | 17202 | RSS: Main: 186945536 10:01:21 INFO - PROCESS | 17202 | 10:04:24 INFO - PROCESS | 17202 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-yui.html (next: http://localhost:59364/tests/dromaeo/cssquery-dojo.html) 10:04:24 INFO - PROCESS | 17202 | RSS: Main: 189046784 10:04:24 INFO - PROCESS | 17202 | 10:04:24 INFO - PROCESS | 17202 | __start_tp_report 10:04:24 INFO - PROCESS | 17202 | _x_x_mozilla_page_load 10:04:24 INFO - PROCESS | 17202 | _x_x_mozilla_page_load_details 10:04:24 INFO - PROCESS | 17202 | |i|pagename|runs| 10:04:24 INFO - PROCESS | 17202 | |0;dojo.html;3094.7060029297218;3134.686531346867;3162.1146079097853;3164.3196712706763;3178.936421271576;5415.783368665254;5463.207834863947;5465.262189604402;5490.313710786152;5518.006758783417;5328.733563321838;5349.117395629716;5429.4570542945685;5484.670919744808;5531.557475401968;4899.387576552922;4927.063857866994;5055.9747201263945;5097.158968770148;5141.280220769096;739.1014615433103;4994.275830004647;5052.0906236877345;5071.163258062434;5115.641905066647;4991.6256280778725;4992.650514463989;5009.173486374744;5010.273510340999;5064.987002599495;4939.950600493985;5030.4215015272985;5037.798488060474;5041.521055499722;5056.443791182967;4916.754162291871;4957.950420495785;4961.826336078256;4964.05682920244;5004.674696144775;5441.809536666197;5450.809221677262;5451.209574611698;5458.863528411782;5533.114701647717;5700.087985922274;5834.737436815353;5872.941270587282;5896.557758168112;5906.26171728534;5945.970270148665;5959.672218028007;5969.791057313017;5987.311459182206;6029.246344206974;5500.202470641734;5502.339719233718;5530.668159910378;5537.529310008614;5547.5007249347345;5754.280714910637;5941.465268125889;5975.40245975399;5986.7904623338845;6003.549733769984;5753.050746626844;5760.798372056958;5774.2782152230975;5787.594868359174;5804.361520232771;5848.2689663792025;5854.063349864001;5855.765769369177;5858.355580886185;5872.530197584183;5657.321121465368;5805.158252053513;5863.384344643836;5905.616134951214;5912.408759124053;5617.073182924772;5700.367829804189;5749.68376739275;5764.654120752768;5922.644641321448;4470.530594287618;4476.865694029184;4487.932681009787;4495.393121928563;4516.661250406232;3926.9803650982135;3968.444417781513;3992.48097747291;4009.578994205625;4011.097503061788;5559.63862348946;5603.7758489659955;5651.632643878134;5667.886642267132;5685.3177618685195;5721.713914304268;5870.090136028923;5920;5926.555508336892;5928.703564821742;5550.195221692913;5585.441455854463;5591;5600.383957764642;5641.52047075995;5078.771455284521;5088.72012039334;5099.311592934981;5129.769160387791;5155.819546315861;5901.852453688606;6014.849628759316;6098.207233059763;6114.205153330038;6118.877622447615;5849.88300233993;5871.2073870027;5921.703914804157;5949.137375080502;5954.493868021266;6048.576599637983;6093.634381937098;6094.116353128683;6100.847478813065;6119.908201376894;5665.971670141623;5746.683932383759;5748.827535173951;5818.709064546841;5830.650160990354;5829.737661805144;5895.174675545341;5924.555658325729;5932.2584676915385;5961.7615295387695;5664.320281566073;5689.118186681071;5711.914321285267;5719.599628026164;5726.370099288992;5572.860678482908;5657.32112146545;5691.715414229355;5704.344000440003;5717.22817419643;5417.756200970887;5565.805196818092;5613.88772224545;5629.437056294338;5671.432856714296;5721.5136713379825;5806.506446952057;5829.795957141479;5846.327672317738;5855.3266374367495;5485.533729633026;5558.110702287615;5606.383297837317;5629.605927585029;5714.085746280575 10:04:24 INFO - PROCESS | 17202 | |1;ext.html;579.5392662833048;612.5038718637903;636.5162476517845;640.6956695569608;644.2140588482054;41819.58180418195;43133;43386.56613433869;46346.07307853841;46394;44651;44840.551594484044;45097;45157.77421112898;45544.31683524742;8916.063813299592;9003.639854405816;9064.954675226614;9065.773355666128;9070.229030532413;8876.644934202624;8975.596098175565;8976.506292153928;8976.685815996441;8977.910220897806;8924.910750892506;8950.462972221654;9036.50299233542;9064.592093355815;9084.909150908505;8974.41666291689;8996.910030899706;9013.639454421815;9015.954920225422;9016.098390160996;8944.776380590472;8948.776280592972;8989.056149104315;8998.865017024684;9026.052264512196;42672.78663606693;43045.78477107626;43083.56916430827;43113.784431077955;43124.56875431237;3555.6622120898473;3602.171500554861;3849.8845034649007;3955.3078211312904;4063.1061166543313;30063.398732025238;31754.682453175636;31982.520262196085;32613.184670383194;33486.162845928804;4352.434183556149;4356.281213599752;4380.3210502372185;4489.6408287336935;4551.817927282905;364849;365067;366201;366543;370605;55615.49730262148;55688.72155639196;55959.44040559542;56046.71976640172;56073.43926560682;34998.47502287468;35748.642513575054;35910.8204458976;37951.81024094862;37987.620123798406;17739.73390399145;17892.46322610324;17980.460586182435;17988.2804687811;17989.460316190536;13187.868121318856;13192.802107968388;13299.401526931118;13301.93349033268;13305.93347033278;19075.427737167905;19106;19120.41874346973;19221.61556768885;19342.129604167563;7045.859082818315;7109.395701365442;7143.89284160738;7204.891926621105;7279.344858962613;953.4517652349926;1023.4268809466722;1029.505837198149;1112.5536802157164;1126.3692332293942;32217.51673724896;32649.183770405456;32744.508832367534;32794;32937.17657058545;1107.7729065541544;1114.7436089699252;1128.4075860173311;1128.7178205448638;1198.8261702053153;17077;17257.223424945656;17283.481495555152;17285.56786080358;17330;614872;619267;623564;624199;627030;56397.15404268939;57092.429075708715;57143;57461;57512.42487575071;1327.157255142991;1346.582559406587;1366.4943970730894;1370.2532119994628;1378.7518246715488;30405.391892162475;31870.52194217042;32394.83802580972;32425.35149297048;32650;50068;50295.748521258625;50542.74728626334;50587.24119138142;50747.746261268454;498021;505320;505447;506589;506980;26820.329491762863;26927.192184234504;27079;27091.72908270892;27151.185464436097;46624.06751865012;46853.29720054134;47160.58518244458;48275.517244827104;48487.27269090896;40057.79971100126;40154.799226003684;40374.19251614893;40692.593074070064;41089.58910410858;39909.401358979056;40698.59301406948;40734.79632601818;41042.58957410388;41340.1731965353;39566.802165988986;40143.19355628945;41022.79488602538;41286.1742765149;44298;33551.49672754862;36853;36976.81511592425;37375.813120934225;37456.25087498289;28033.719662803112;28730.684052056135;28749.56875646909;28960.710392896643;29013.129606111852 10:04:24 INFO - PROCESS | 17202 | |2;jquery.html;383.2813474734872;387.9844806207752;392.6583872031332;395.8416633346661;417.04288657530964;13961.511347102853;15084.698306033873;17618.91190544047;19050.809491905078;19167.52081197969;15749.448769293078;16085.356585736556;18121.728174077365;18441.53896152597;18556.721649175273;5576.33084029916;5751.338596061444;5760.049591817345;5834.854128646796;5842.853928651796;5483.341998960111;5756.654600723949;5759.3376761672525;5790.884182316351;5799.420057994209;5680.318361796591;5715.5427565794635;6633.170853643294;7016.649167541628;7021.75423860165;6942.132233470817;7023.89464158038;7111.217766045731;7504.399648028199;7505.474616776828;6984.4412447004115;7181.174164970991;7207.135143782727;7234.891476627855;7260.439005613765;23823.523529529313;23912;24593.87703061473;25111.497770044498;25299.747002529923;2265.6261716816707;2343.7539058398793;2524.823262371635;2560.423904621445;2828.9957065241956;15454.304556294994;15539.611509712347;15723.13522756248;15769.132697701622;16162.353505859752;2078.7505499340023;2079.688046792978;2081.510844951435;2146.647731519555;2193.3419974007734;72263.63868180678;74748.25251747467;77537.61231193865;95813;98591;16086.83913160877;17482.912585437247;17510.474685759447;17557.297708091533;17864.91067544654;30450.84774576113;30497;30506.84746576253;31012.53481197784;31023.379532409224;9780.364276322016;10389;10429.21780866438;10438.425886576311;10475.214358923111;8844.911550884537;8858.955705221433;8873.334499912404;8943.195112439911;8993.190612844875;8792.164744349277;8802.515861627544;9029.683961061332;9045.909540904639;9102.86345704815;3361.411752943274;3513.209527856263;3524.524189234472;3583.211693427442;3585.8386372613295;879.2043200903192;1033.3128469567803;1040.167865707431;1081.2269227502375;1104.5913012185542;18543.35098271554;18870.52823679419;19054.52363690891;19220.135093920806;19456.22175113008;981.4307701533094;985.8028394321165;1008.1380419741163;1043.4834756795435;1059.8251288537306;10394;10761.363749415541;10822.842801370547;10848.945755271174;10936.398498082683;455688;464365;525287;529740;532372;63343.36656633467;86899;87018.56490717632;93078;96881;1021.8620486234412;1048.4233671480656;1055.762453447968;1070.8447275145215;1073.9570417183381;16646.583835404213;16961.830381696025;17172.828271717124;17452;17651;41337.79331103325;41412.378814318414;41414.37878431886;41586.792066039474;43070.35394469148;57073.71463142658;58986;60868.695656521435;61427.385726143955;61795.382046178966;8156.306713929383;8300.08699043117;8388.832223355377;8473.5339556325;8710;10014.449205293779;11757.882421175678;12827.42276597574;12898;13002.08985371015;11017.83473247886;11447.599334023269;11700.414979251174;11709.121815863675;11815.232009919328;11396.715082123013;11474.311541307548;11606.825897611374;11626.53493860236;11971.10216733731;8798.34012449056;11358.60244891425;11404.771904562029;11465.484053217791;11730.826917308543;8083.878741818995;8118;8221.54781487024;8273.875891861748;8320.958395207985;10764.138868890313;11002.779944401227;11246.325220486797;11304.604338848101;11550.480228389575 10:04:24 INFO - PROCESS | 17202 | |3;mootools.html;1462.1592584264047;1475.9483418080365;1513.9318730657126;1597.8322276161002;1637.7215873301539;7795.883061754078;8169.346452283803;8356.83286334273;8869.42348747331;8891.244244239238;8280.792980175484;8455.239028487435;8555.828883422344;8638;8659.134086591337;2267.1951457232694;2325.2907863101746;2326.7091613548305;2336.0889253191267;2346.155384061736;2319.7332306784683;2329.8136149108113;2347.9765202348012;2360.1385494294545;2361.2916125162383;2269.909203631853;2276.7837055479786;2283.9200627978025;2294.19703103914;2294.7819957104134;2198.923037693681;2238.0600147937826;2239.6864438978555;2240.2271216430386;2256.435891027243;2304.585174668559;2334.159702507096;2350.3536527455085;2360.138549429463;2360.7875291223872;8569.871451928226;8687.305015598737;8688.522131282776;8696.17386348296;8716.302695784321;5214.791408343662;5364.409914909357;5366.060939335601;5370.409254981949;5395.730213489349;3347.1799409144674;3356.8992930212135;3398.660133986606;3508.8070156141403;3521.3309471200646;1179.958701445454;1180.7815554122515;1206.3485717712424;1220.7436438347956;1220.9145359824815;12171.817422738666;12183.32991685457;12185.147039707224;12261.570845020471;12308.446119924625;4611.423572053493;4636.4899861015265;4743.952560474351;4744.928826067612;4753.904921901542;10368;10403.53184106717;10437.373757574569;10440.68677939663;10456.634017809492;5360.490753378423;5398.541124004503;5407.486288802557;5416.268803711528;5433.673979561239;4340.110277393127;4645.140648979949;4781.545753153445;4800.807967681254;4886.95113048865;4063.756174629532;4077.327241005201;4106.488626781959;4110.958890411118;4141.834326626901;1238.8389509363726;1249.2192379762648;1268.2770820632152;1271.5613113475836;1284.8650891656428;1000.214831357381;1014.8883622801634;1017.0033367300088;1026.7843752811993;1028.547439126782;6015.699215039231;6286.182796236551;6305.306416294204;6338.207724034496;6412.2625898022325;441.6466826538756;449.05249922663154;451.93898823659043;456.7236821722876;460.9539046095364;4410.911781764346;4444.799984000728;4455;4472.08322293929;4479.843205487792;10605.310654807412;10945.616903408501;10950.726231844268;10974.561017559368;10997.560097596166;10300;10718.571257149626;10774.676759697222;11081.778364432666;11091.389973551371;7804.921950780533;7942.126366099725;7945.801354966172;7955.482893612012;7984.001999750031;6162.784302549389;6408;6538.280789113099;6574.342565743387;6608.306127856506;9826.361286516354;10304.072633463024;10348.948255258676;10406.791864162826;10419.479026048515;10144.54349554257;10311.845322320021;10522.526486308288;10545.525451354553;10595.523201455799;7631.656575454229;8250.628721707657;8328.750137495885;8407.663693452194;8444.451110677786;8590.398672092893;8629.913700862911;8630.697925572575;8652.826943461221;8710.956445217733;7591.3547348475995;7776.533407995538;7794.142644309235;7857.174996625272;7887.092984306878;7530.924690753022;7565.130010048915;7567.508111972704;7627.656755445907;7780.92219077802;6960.8955865663065;7126.821829454305;7148.28517148281;7148.606826624377;7159.964200178966;5296.364436267672;5443.482869127427;5458.044842152528;5547.389787123332;5603.467670571289;5502.378002477938;5569.777208911598;5571.247881535941;5579.972100139474;5634.070378387521 10:04:24 INFO - PROCESS | 17202 | |4;prototype.html;325.1027165024532;332.9495441880866;333.9448990916499;336.92756057447644;337.9104537297617;5554.305711786027;5556.194351818989;5564.527015203713;5585.776568937237;5617.7752889884405;5408.486193811582;5494.450554944514;5496.615236933406;5504.4770746779095;5521.558275337973;4231.428757117796;4259.297215959363;4321.94112442452;4365.694401391904;4382.802773875183;4233.470816147981;4279.2083464559155;4314.158739045887;4328.3074708046715;4372.338511365677;4261.616454519108;4276.6101017169385;4340.240457919867;4365.738055716652;4398.318260669601;4150.58494150584;4164.5210800758;4326.913461730779;4338.197433474786;4378.430803995476;3774.792386418746;3790.431435284702;3800.365842687643;3805.6004119567324;3807.695384369244;5403.432639572828;5403.621746477748;5419;5454.61817672763;5455.399906010336;4804.495527969548;4972.726500042496;4980.5019498049905;4988.501149885019;5013.420772456664;5792.4497172768515;5813.854653633651;5828.2131912191735;5828.41715828418;5851.590388672795;4242;4249.3413520904305;4254.361845723166;4261.275583150872;4265.829366825324;5769.653820770725;5988.880222395528;6037.607555508878;6095.847603809896;6141.692915354259;4159.542450330461;4160.188763191149;4193.5387107418155;4222.21888950539;4224.78876056196;4250.427341883523;4253.213155566168;4274.508431530414;4277.1873344064525;4281.143771245764;4737.8104875805275;4878.658493905393;4912.04215178044;4921.630877684188;4959.404871415381;5874.50066744323;5882.294124704978;5915.822525324247;5920.230370051866;5920.851978700567;1446.7395868743727;1461.1087236785552;1468.3539242733164;1487.2043456750587;1490.5528341497507;915.0580882462914;938.591712605019;948.796008858085;950.6387572722322;950.7924935332089;5054.191329387354;5108.952664703726;5117.8464646060675;5120.334356533701;5184.585233181412;5292.8355761732355;5386.8383948481605;5412.864678383072;5441.183822426668;5459.426760190202;5123.923141152885;5181.896362072813;5433.157860531624;5721.542276617861;5727.627704199213;3200.455922493182;3207.957413840511;3215.807051576866;3225.5806745123455;3229.515572664119;6040.214772079689;6194.783182588588;6217;6217.906731399033;6234.812955611339;5996.460318571262;6079;6104.938950610437;6134.883465204497;6139.662318572521;6219.40915613016;6224.439800417984;6258.968705156445;6264.310925798159;6268.592541484698;5865.4134586541;6001.2498437695285;6036.788712395045;6041.728122234598;6073.240844894388;5962.55280853929;5991.310999235144;6005.489533389711;6007.279126504847;6066.393360663898;6030.879382412415;6283.528735344776;6298.244210694563;6309;6325.146105275913;4156.625903668684;4193.706440549132;4208.431861698754;4213.241616508935;4252.851730032936;6002.849928751816;6032.487238584769;6071.423214794588;6076.784643071315;6106.603070800384;5726.599138060295;5749.511291540266;5871.794487192928;5877.706114694162;5912.379200183918;5719.8570035749435;5754.6547207167705;5788.479036886701;5828.417158284137;5879.530117470632;5138.897222055463;5766.971165144148;5801.970990145022;5808.273965754281;5823.534117270524;5887.61730487517;5894;5916.934951708734;5921.348651648229;5923.555733319932;5738.1679656450415;5779.190913272229;5803.665157013826;5827.455724233167;5861.443162899518 10:04:24 INFO - PROCESS | 17202 | |5;yui.html;750.0324581290135;778.5873487051861;789.2659826361485;789.3645615279697;793.8531371696234;17246;17859.464216073506;17934.910325448356;17994.91002544987;18013.549661258476;16841.41055063073;16871.24079416426;16974.745378819327;17038.914805425986;17042;670.7819958513478;820.4011071917504;820.409305300183;820.659426338072;823.1644880446352;795.3001358804244;828.7306625346756;831.7005877883956;832.9708460203894;833.170994860115;858.2618947704968;867.8177582707639;869.5565261716507;870.8824308718337;871.1375738019346;858.5964596639569;864.4165188497739;864.4337958637103;864.7924498120437;865.8441480533502;623.8440389902524;624.1511544299749;624.3101372982834;628.2084573437456;629.6316654756972;14457.566273011826;14520;14523.78214326786;14536.491222807152;14572.635684107876;14446.927765361106;14507.854921450757;14577;14638.560843174722;14722.337494812651;11839.704007399798;11965.282083075042;12026.098042646836;12071.275723456622;12103.334316612583;3703.3148867459336;3876.0116170376655;3941.0147463134217;3947.684185265172;3957.5053118360206;71197.28802711959;72492.27507724908;72540.99999999948;72795;74855.25144748537;11099.38953357557;11155.498002589902;11169.497372618089;11289.37908415045;11666.300021998537;20674.483137921674;20766.58466830655;20933.476663083544;20983.79016209849;21000.579988400452;8307.08622051574;8396;8461.238488535939;8488.872666910001;8529.786755331166;4713.835015774432;4716.8113275468595;4848.5636292733825;4908.11653902301;4965.428975667773;3462.9826850865584;3548.432250839905;3567.2152126532123;3571.196480791853;3591.3894637911617;520.9947900521022;624.6595605395071;638.2946843737695;640.1390130274866;640.782134074417;676.7293082766932;694.6665600511682;714.1893950366372;721.8917162425573;724.9275072492813;9925.30522863407;9985.20118390527;10011.899881001096;10103.141232995278;10135.695929122137;613.5122577550858;656.1306269193337;675.5676367125044;684.5447777228187;689.3072462175481;4312.37470566766;4517.683762136685;4538.804531814116;4696.436427628706;4705.60002399793;92556.53721731348;95605;110022.44988775004;118419;118683;60633;82312.76530852042;87581.68627470593;97374;97462;57252;63954.040689389694;83931.58034209911;84400;90167;9362.103174603175;9372.625094996123;9527.761805954906;9609.56756945953;9618.182454491447;48093.75953120212;48224;48422;48991;49760.25359619681;74174.51650967059;75848;78425.60787196028;78890.21109788828;79487;12631.589435977645;12734.936325318315;12755.48978040868;12942.223466592035;12985.766352196526;14248.786268206193;14420.206888621227;14876.925615372287;15062.32219550101;15268.160251185847;12552.686182845136;13618.931905340807;13648.863511365156;13901.51344702971;14612.269386530843;12988.935055324662;13180.406881690538;13192.142510736772;13383.665408364868;14160.645983850074;12176.756464870476;13199.406026728628;13303.86696133065;13648.590542283748;13863;10484.685459436228;10527.894721052691;11087.22389432732;11950.521979120738;12076.51693932268;10712.571497140027;10849.566017359217;11918.52325906954;11993.280403175837;12073.698157546132 10:04:24 INFO - PROCESS | 17202 | __end_tp_report 10:04:24 INFO - PROCESS | 17202 | __start_cc_report 10:04:24 INFO - PROCESS | 17202 | _x_x_mozilla_cycle_collect,333 10:04:24 INFO - PROCESS | 17202 | __end_cc_report 10:04:24 INFO - PROCESS | 17202 | __startTimestamp1465491864457__endTimestamp 10:04:24 INFO - PROCESS | 17202 | 10:04:24 INFO - PROCESS | 17202 | ------- Summary: start ------- 10:04:24 INFO - PROCESS | 17202 | Number of tests: 6 10:04:24 INFO - PROCESS | 17202 | 10:04:24 INFO - PROCESS | 17202 | [#0] dojo.html Cycles:165 Average:5423.60 Median:5657.32 stddev:718.16 (12.7%) stddev-sans-first:696.73 10:04:24 INFO - PROCESS | 17202 | Values: 3094.7 3134.7 3162.1 3164.3 3178.9 5415.8 5463.2 5465.3 5490.3 5518.0 5328.7 5349.1 5429.5 5484.7 5531.6 4899.4 4927.1 5056.0 5097.2 5141.3 739.1 4994.3 5052.1 5071.2 5115.6 4991.6 4992.7 5009.2 5010.3 5065.0 4940.0 5030.4 5037.8 5041.5 5056.4 4916.8 4958.0 4961.8 4964.1 5004.7 5441.8 5450.8 5451.2 5458.9 5533.1 5700.1 5834.7 5872.9 5896.6 5906.3 5946.0 5959.7 5969.8 5987.3 6029.2 5500.2 5502.3 5530.7 5537.5 5547.5 5754.3 5941.5 5975.4 5986.8 6003.5 5753.1 5760.8 5774.3 5787.6 5804.4 5848.3 5854.1 5855.8 5858.4 5872.5 5657.3 5805.2 5863.4 5905.6 5912.4 5617.1 5700.4 5749.7 5764.7 5922.6 4470.5 4476.9 4487.9 4495.4 4516.7 3927.0 3968.4 3992.5 4009.6 4011.1 5559.6 5603.8 5651.6 5667.9 5685.3 5721.7 5870.1 5920.0 5926.6 5928.7 5550.2 5585.4 5591.0 5600.4 5641.5 5078.8 5088.7 5099.3 5129.8 5155.8 5901.9 6014.8 6098.2 6114.2 6118.9 5849.9 5871.2 5921.7 5949.1 5954.5 6048.6 6093.6 6094.1 6100.8 6119.9 5666.0 5746.7 5748.8 5818.7 5830.7 5829.7 5895.2 5924.6 5932.3 5961.8 5664.3 5689.1 5711.9 5719.6 5726.4 5572.9 5657.3 5691.7 5704.3 5717.2 5417.8 5565.8 5613.9 5629.4 5671.4 5721.5 5806.5 5829.8 5846.3 5855.3 5485.5 5558.1 5606.4 5629.6 5714.1 10:04:24 INFO - PROCESS | 17202 | 10:04:24 INFO - PROCESS | 17202 | [#1] ext.html Cycles:180 Average:64333.32 Median:41187.88 stddev:135530.95 (329.1%) stddev-sans-first:135826.62 10:04:24 INFO - PROCESS | 17202 | Values: 579.5 612.5 636.5 640.7 644.2 41819.6 43133.0 43386.6 46346.1 46394.0 44651.0 44840.6 45097.0 45157.8 45544.3 8916.1 9003.6 9065.0 9065.8 9070.2 8876.6 8975.6 8976.5 8976.7 8977.9 8924.9 8950.5 9036.5 9064.6 9084.9 8974.4 8996.9 9013.6 9016.0 9016.1 8944.8 8948.8 8989.1 8998.9 9026.1 42672.8 43045.8 43083.6 43113.8 43124.6 3555.7 3602.2 3849.9 3955.3 4063.1 30063.4 31754.7 31982.5 32613.2 33486.2 4352.4 4356.3 4380.3 4489.6 4551.8 364849.0 365067.0 366201.0 366543.0 370605.0 55615.5 55688.7 55959.4 56046.7 56073.4 34998.5 35748.6 35910.8 37951.8 37987.6 17739.7 17892.5 17980.5 17988.3 17989.5 13187.9 13192.8 13299.4 13301.9 13305.9 19075.4 19106.0 19120.4 19221.6 19342.1 7045.9 7109.4 7143.9 7204.9 7279.3 953.5 1023.4 1029.5 1112.6 1126.4 32217.5 32649.2 32744.5 32794.0 32937.2 1107.8 1114.7 1128.4 1128.7 1198.8 17077.0 17257.2 17283.5 17285.6 17330.0 614872.0 619267.0 623564.0 624199.0 627030.0 56397.2 57092.4 57143.0 57461.0 57512.4 1327.2 1346.6 1366.5 1370.3 1378.8 30405.4 31870.5 32394.8 32425.4 32650.0 50068.0 50295.7 50542.7 50587.2 50747.7 498021.0 505320.0 505447.0 506589.0 506980.0 26820.3 26927.2 27079.0 27091.7 27151.2 46624.1 46853.3 47160.6 48275.5 48487.3 40057.8 40154.8 40374.2 40692.6 41089.6 39909.4 40698.6 40734.8 41042.6 41340.2 39566.8 40143.2 41022.8 41286.2 44298.0 33551.5 36853.0 36976.8 37375.8 37456.3 28033.7 28730.7 28749.6 28960.7 29013.1 10:04:24 INFO - PROCESS | 17202 | 10:04:24 INFO - PROCESS | 17202 | [#2] jquery.html Cycles:180 Average:30227.02 Median:30473.92 stddev:82634.23 (271.2%) stddev-sans-first:82835.66 10:04:24 INFO - PROCESS | 17202 | Values: 383.3 388.0 392.7 395.8 417.0 13961.5 15084.7 17618.9 19050.8 19167.5 15749.4 16085.4 18121.7 18441.5 18556.7 5576.3 5751.3 5760.0 5834.9 5842.9 5483.3 5756.7 5759.3 5790.9 5799.4 5680.3 5715.5 6633.2 7016.6 7021.8 6942.1 7023.9 7111.2 7504.4 7505.5 6984.4 7181.2 7207.1 7234.9 7260.4 23823.5 23912.0 24593.9 25111.5 25299.7 2265.6 2343.8 2524.8 2560.4 2829.0 15454.3 15539.6 15723.1 15769.1 16162.4 2078.8 2079.7 2081.5 2146.6 2193.3 72263.6 74748.3 77537.6 95813.0 98591.0 16086.8 17482.9 17510.5 17557.3 17864.9 30450.8 30497.0 30506.8 31012.5 31023.4 9780.4 10389.0 10429.2 10438.4 10475.2 8844.9 8859.0 8873.3 8943.2 8993.2 8792.2 8802.5 9029.7 9045.9 9102.9 3361.4 3513.2 3524.5 3583.2 3585.8 879.2 1033.3 1040.2 1081.2 1104.6 18543.4 18870.5 19054.5 19220.1 19456.2 981.4 985.8 1008.1 1043.5 1059.8 10394.0 10761.4 10822.8 10848.9 10936.4 455688.0 464365.0 525287.0 529740.0 532372.0 63343.4 86899.0 87018.6 93078.0 96881.0 1021.9 1048.4 1055.8 1070.8 1074.0 16646.6 16961.8 17172.8 17452.0 17651.0 41337.8 41412.4 41414.4 41586.8 43070.4 57073.7 58986.0 60868.7 61427.4 61795.4 8156.3 8300.1 8388.8 8473.5 8710.0 10014.4 11757.9 12827.4 12898.0 13002.1 11017.8 11447.6 11700.4 11709.1 11815.2 11396.7 11474.3 11606.8 11626.5 11971.1 8798.3 11358.6 11404.8 11465.5 11730.8 8083.9 8118.0 8221.5 8273.9 8321.0 10764.1 11002.8 11246.3 11304.6 11550.5 10:04:24 INFO - PROCESS | 17202 | 10:04:24 INFO - PROCESS | 17202 | [#3] mootools.html Cycles:180 Average:5855.28 Median:2464.45 stddev:3307.11 (134.2%) stddev-sans-first:3299.91 10:04:24 INFO - PROCESS | 17202 | Values: 1462.2 1475.9 1513.9 1597.8 1637.7 7795.9 8169.3 8356.8 8869.4 8891.2 8280.8 8455.2 8555.8 8638.0 8659.1 2267.2 2325.3 2326.7 2336.1 2346.2 2319.7 2329.8 2348.0 2360.1 2361.3 2269.9 2276.8 2283.9 2294.2 2294.8 2198.9 2238.1 2239.7 2240.2 2256.4 2304.6 2334.2 2350.4 2360.1 2360.8 8569.9 8687.3 8688.5 8696.2 8716.3 5214.8 5364.4 5366.1 5370.4 5395.7 3347.2 3356.9 3398.7 3508.8 3521.3 1180.0 1180.8 1206.3 1220.7 1220.9 12171.8 12183.3 12185.1 12261.6 12308.4 4611.4 4636.5 4744.0 4744.9 4753.9 10368.0 10403.5 10437.4 10440.7 10456.6 5360.5 5398.5 5407.5 5416.3 5433.7 4340.1 4645.1 4781.5 4800.8 4887.0 4063.8 4077.3 4106.5 4111.0 4141.8 1238.8 1249.2 1268.3 1271.6 1284.9 1000.2 1014.9 1017.0 1026.8 1028.5 6015.7 6286.2 6305.3 6338.2 6412.3 441.6 449.1 451.9 456.7 461.0 4410.9 4444.8 4455.0 4472.1 4479.8 10605.3 10945.6 10950.7 10974.6 10997.6 10300.0 10718.6 10774.7 11081.8 11091.4 7804.9 7942.1 7945.8 7955.5 7984.0 6162.8 6408.0 6538.3 6574.3 6608.3 9826.4 10304.1 10348.9 10406.8 10419.5 10144.5 10311.8 10522.5 10545.5 10595.5 7631.7 8250.6 8328.8 8407.7 8444.5 8590.4 8629.9 8630.7 8652.8 8711.0 7591.4 7776.5 7794.1 7857.2 7887.1 7530.9 7565.1 7567.5 7627.7 7780.9 6960.9 7126.8 7148.3 7148.6 7160.0 5296.4 5443.5 5458.0 5547.4 5603.5 5502.4 5569.8 5571.2 5580.0 5634.1 10:04:24 INFO - PROCESS | 17202 | 10:04:24 INFO - PROCESS | 17202 | [#4] prototype.html Cycles:180 Average:4881.62 Median:5495.53 stddev:1448.29 (26.4%) stddev-sans-first:1411.39 10:04:24 INFO - PROCESS | 17202 | Values: 325.1 332.9 333.9 336.9 337.9 5554.3 5556.2 5564.5 5585.8 5617.8 5408.5 5494.5 5496.6 5504.5 5521.6 4231.4 4259.3 4321.9 4365.7 4382.8 4233.5 4279.2 4314.2 4328.3 4372.3 4261.6 4276.6 4340.2 4365.7 4398.3 4150.6 4164.5 4326.9 4338.2 4378.4 3774.8 3790.4 3800.4 3805.6 3807.7 5403.4 5403.6 5419.0 5454.6 5455.4 4804.5 4972.7 4980.5 4988.5 5013.4 5792.4 5813.9 5828.2 5828.4 5851.6 4242.0 4249.3 4254.4 4261.3 4265.8 5769.7 5988.9 6037.6 6095.8 6141.7 4159.5 4160.2 4193.5 4222.2 4224.8 4250.4 4253.2 4274.5 4277.2 4281.1 4737.8 4878.7 4912.0 4921.6 4959.4 5874.5 5882.3 5915.8 5920.2 5920.9 1446.7 1461.1 1468.4 1487.2 1490.6 915.1 938.6 948.8 950.6 950.8 5054.2 5109.0 5117.8 5120.3 5184.6 5292.8 5386.8 5412.9 5441.2 5459.4 5123.9 5181.9 5433.2 5721.5 5727.6 3200.5 3208.0 3215.8 3225.6 3229.5 6040.2 6194.8 6217.0 6217.9 6234.8 5996.5 6079.0 6104.9 6134.9 6139.7 6219.4 6224.4 6259.0 6264.3 6268.6 5865.4 6001.2 6036.8 6041.7 6073.2 5962.6 5991.3 6005.5 6007.3 6066.4 6030.9 6283.5 6298.2 6309.0 6325.1 4156.6 4193.7 4208.4 4213.2 4252.9 6002.8 6032.5 6071.4 6076.8 6106.6 5726.6 5749.5 5871.8 5877.7 5912.4 5719.9 5754.7 5788.5 5828.4 5879.5 5138.9 5767.0 5802.0 5808.3 5823.5 5887.6 5894.0 5916.9 5921.3 5923.6 5738.2 5779.2 5803.7 5827.5 5861.4 10:04:24 INFO - PROCESS | 17202 | 10:04:24 INFO - PROCESS | 17202 | [#5] yui.html Cycles:180 Average:19918.08 Median:4709.72 stddev:27752.20 (589.3%) stddev-sans-first:27792.73 10:04:24 INFO - PROCESS | 17202 | Values: 750.0 778.6 789.3 789.4 793.9 17246.0 17859.5 17934.9 17994.9 18013.5 16841.4 16871.2 16974.7 17038.9 17042.0 670.8 820.4 820.4 820.7 823.2 795.3 828.7 831.7 833.0 833.2 858.3 867.8 869.6 870.9 871.1 858.6 864.4 864.4 864.8 865.8 623.8 624.2 624.3 628.2 629.6 14457.6 14520.0 14523.8 14536.5 14572.6 14446.9 14507.9 14577.0 14638.6 14722.3 11839.7 11965.3 12026.1 12071.3 12103.3 3703.3 3876.0 3941.0 3947.7 3957.5 71197.3 72492.3 72541.0 72795.0 74855.3 11099.4 11155.5 11169.5 11289.4 11666.3 20674.5 20766.6 20933.5 20983.8 21000.6 8307.1 8396.0 8461.2 8488.9 8529.8 4713.8 4716.8 4848.6 4908.1 4965.4 3463.0 3548.4 3567.2 3571.2 3591.4 521.0 624.7 638.3 640.1 640.8 676.7 694.7 714.2 721.9 724.9 9925.3 9985.2 10011.9 10103.1 10135.7 613.5 656.1 675.6 684.5 689.3 4312.4 4517.7 4538.8 4696.4 4705.6 92556.5 95605.0 110022.4 118419.0 118683.0 60633.0 82312.8 87581.7 97374.0 97462.0 57252.0 63954.0 83931.6 84400.0 90167.0 9362.1 9372.6 9527.8 9609.6 9618.2 48093.8 48224.0 48422.0 48991.0 49760.3 74174.5 75848.0 78425.6 78890.2 79487.0 12631.6 12734.9 12755.5 12942.2 12985.8 14248.8 14420.2 14876.9 15062.3 15268.2 12552.7 13618.9 13648.9 13901.5 14612.3 12988.9 13180.4 13192.1 13383.7 14160.6 12176.8 13199.4 13303.9 13648.6 13863.0 10484.7 10527.9 11087.2 11950.5 12076.5 10712.6 10849.6 11918.5 11993.3 12073.7 10:04:24 INFO - PROCESS | 17202 | -------- Summary: end -------- 10:04:24 INFO - PROCESS | 17202 | 10:04:25 INFO - TEST-INFO | 17202: exit 0 10:04:25 INFO - TEST-OK | dromaeo_css | took 1111168ms 10:04:25 INFO - TEST-START | kraken 10:04:25 INFO - operating with platform_type : linux_ 10:04:25 INFO - Initialising browser for kraken test... 10:04:25 INFO - TEST-INFO | started process 17441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDNOmco/profile http://localhost:59364/getInfo.html) 10:04:29 INFO - PROCESS | 17441 | __metrics Screen width/height:1600/1200 10:04:29 INFO - PROCESS | 17441 | colorDepth:24 10:04:29 INFO - PROCESS | 17441 | Browser inner width/height: 1024/697 10:04:29 INFO - PROCESS | 17441 | __metrics 10:04:30 ERROR - PROCESS | 17441 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:04:31 INFO - TEST-INFO | 17441: exit 0 10:04:31 INFO - Browser initialized. 10:04:31 INFO - Running cycle 1/1 for kraken test... 10:04:31 INFO - TEST-INFO | started process 17561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDNOmco/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:43 INFO - PROCESS | 17561 | RSS: Main: 184799232 10:04:43 INFO - PROCESS | 17561 | 10:04:45 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59364/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:46 INFO - PROCESS | 17561 | RSS: Main: 190267392 10:04:46 INFO - PROCESS | 17561 | 10:04:49 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59364/tests/kraken/driver.html?testName=audio-dft) 10:04:50 INFO - PROCESS | 17561 | RSS: Main: 189505536 10:04:50 INFO - PROCESS | 17561 | 10:04:53 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59364/tests/kraken/driver.html?testName=audio-fft) 10:04:53 INFO - PROCESS | 17561 | RSS: Main: 184393728 10:04:53 INFO - PROCESS | 17561 | 10:04:55 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59364/tests/kraken/driver.html?testName=audio-oscillator) 10:04:56 INFO - PROCESS | 17561 | RSS: Main: 184766464 10:04:56 INFO - PROCESS | 17561 | 10:04:58 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:04:59 INFO - PROCESS | 17561 | RSS: Main: 184852480 10:04:59 INFO - PROCESS | 17561 | 10:05:02 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59364/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:02 INFO - PROCESS | 17561 | RSS: Main: 185421824 10:05:02 INFO - PROCESS | 17561 | 10:05:06 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59364/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:07 INFO - PROCESS | 17561 | RSS: Main: 183386112 10:05:07 INFO - PROCESS | 17561 | 10:05:09 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59364/tests/kraken/driver.html?testName=json-parse-financial) 10:05:10 INFO - PROCESS | 17561 | RSS: Main: 184119296 10:05:10 INFO - PROCESS | 17561 | 10:05:12 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:12 INFO - PROCESS | 17561 | RSS: Main: 184651776 10:05:12 INFO - PROCESS | 17561 | 10:05:14 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:15 INFO - PROCESS | 17561 | RSS: Main: 185110528 10:05:15 INFO - PROCESS | 17561 | 10:05:17 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:18 INFO - PROCESS | 17561 | RSS: Main: 185823232 10:05:18 INFO - PROCESS | 17561 | 10:05:20 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:21 INFO - PROCESS | 17561 | RSS: Main: 185507840 10:05:21 INFO - PROCESS | 17561 | 10:05:23 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:24 INFO - PROCESS | 17561 | RSS: Main: 185110528 10:05:24 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59364/tests/kraken/driver.html?testName=ai-astar) 10:05:26 INFO - PROCESS | 17561 | RSS: Main: 186114048 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | __start_tp_report 10:05:26 INFO - PROCESS | 17561 | _x_x_mozilla_page_load 10:05:26 INFO - PROCESS | 17561 | _x_x_mozilla_page_load_details 10:05:26 INFO - PROCESS | 17561 | |i|pagename|runs| 10:05:26 INFO - PROCESS | 17561 | |0;ai-astar;111;106;109;111;112;111;110;110;110;109 10:05:26 INFO - PROCESS | 17561 | |1;audio-beat-detection;159;126;158;177;129;154;151;130;181;130 10:05:26 INFO - PROCESS | 17561 | |2;audio-dft;161;162;160;161;165;173;161;162;163;162 10:05:26 INFO - PROCESS | 17561 | |3;audio-fft;75;75;77;159;77;76;75;75;170;77 10:05:26 INFO - PROCESS | 17561 | |4;audio-oscillator;84;85;165;86;84;85;135;85;85;157 10:05:26 INFO - PROCESS | 17561 | |5;imaging-gaussian-blur;117;118;117;119;117;117;118;118;117;118 10:05:26 INFO - PROCESS | 17561 | |6;imaging-darkroom;146;148;146;149;147;147;148;147;148;147 10:05:26 INFO - PROCESS | 17561 | |7;imaging-desaturate;96;95;95;95;95;94;96;95;95;96 10:05:26 INFO - PROCESS | 17561 | |8;json-parse-financial;56;56;57;55;56;55;55;55;57;68 10:05:26 INFO - PROCESS | 17561 | |9;json-stringify-tinderbox;62;60;61;60;61;61;61;60;62;61 10:05:26 INFO - PROCESS | 17561 | |10;stanford-crypto-aes;85;80;79;85;84;80;80;81;106;86 10:05:26 INFO - PROCESS | 17561 | |11;stanford-crypto-ccm;125;125;130;131;121;127;126;132;127;134 10:05:26 INFO - PROCESS | 17561 | |12;stanford-crypto-pbkdf2;165;163;162;164;163;164;166;160;159;169 10:05:26 INFO - PROCESS | 17561 | |13;stanford-crypto-sha256-iterative;67;65;63;64;65;63;63;64;64;68 10:05:26 INFO - PROCESS | 17561 | __end_tp_report 10:05:26 INFO - PROCESS | 17561 | __start_cc_report 10:05:26 INFO - PROCESS | 17561 | _x_x_mozilla_cycle_collect,885 10:05:26 INFO - PROCESS | 17561 | __end_cc_report 10:05:26 INFO - PROCESS | 17561 | __startTimestamp1465491926456__endTimestamp 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | ------- Summary: start ------- 10:05:26 INFO - PROCESS | 17561 | Number of tests: 14 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:1.66 (1.5%) stddev-sans-first:1.72 10:05:26 INFO - PROCESS | 17561 | Values: 111.0 106.0 109.0 111.0 112.0 111.0 110.0 110.0 110.0 109.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:156.00 stddev:20.18 (12.9%) stddev-sans-first:21.11 10:05:26 INFO - PROCESS | 17561 | Values: 159.0 126.0 158.0 177.0 129.0 154.0 151.0 130.0 181.0 130.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:3.77 (2.3%) stddev-sans-first:3.93 10:05:26 INFO - PROCESS | 17561 | Values: 161.0 162.0 160.0 161.0 165.0 173.0 161.0 162.0 163.0 162.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.50 stddev:37.47 (49.6%) stddev-sans-first:39.13 10:05:26 INFO - PROCESS | 17561 | Values: 75.0 75.0 77.0 159.0 77.0 76.0 75.0 75.0 170.0 77.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:85.00 stddev:33.41 (39.3%) stddev-sans-first:34.55 10:05:26 INFO - PROCESS | 17561 | Values: 84.0 85.0 165.0 86.0 84.0 85.0 135.0 85.0 85.0 157.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 10:05:26 INFO - PROCESS | 17561 | Values: 117.0 118.0 117.0 119.0 117.0 117.0 118.0 118.0 117.0 118.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 10:05:26 INFO - PROCESS | 17561 | Values: 146.0 148.0 146.0 149.0 147.0 147.0 148.0 147.0 148.0 147.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 10:05:26 INFO - PROCESS | 17561 | Values: 96.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 96.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:3.94 (7.0%) stddev-sans-first:4.17 10:05:26 INFO - PROCESS | 17561 | Values: 56.0 56.0 57.0 55.0 56.0 55.0 55.0 55.0 57.0 68.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 10:05:26 INFO - PROCESS | 17561 | Values: 62.0 60.0 61.0 60.0 61.0 61.0 61.0 60.0 62.0 61.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:82.50 stddev:7.95 (9.6%) stddev-sans-first:8.43 10:05:26 INFO - PROCESS | 17561 | Values: 85.0 80.0 79.0 85.0 84.0 80.0 80.0 81.0 106.0 86.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:128.50 stddev:3.91 (3.0%) stddev-sans-first:4.01 10:05:26 INFO - PROCESS | 17561 | Values: 125.0 125.0 130.0 131.0 121.0 127.0 126.0 132.0 127.0 134.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:2.88 (1.8%) stddev-sans-first:3.00 10:05:26 INFO - PROCESS | 17561 | Values: 165.0 163.0 162.0 164.0 163.0 164.0 166.0 160.0 159.0 169.0 10:05:26 INFO - PROCESS | 17561 | 10:05:26 INFO - PROCESS | 17561 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:1.71 (2.7%) stddev-sans-first:1.58 10:05:26 INFO - PROCESS | 17561 | Values: 67.0 65.0 63.0 64.0 65.0 63.0 63.0 64.0 64.0 68.0 10:05:26 INFO - PROCESS | 17561 | -------- Summary: end -------- 10:05:26 INFO - PROCESS | 17561 | 10:05:27 INFO - TEST-INFO | 17561: exit 0 10:05:27 INFO - TEST-OK | kraken | took 62278ms 10:05:27 INFO - SUITE-END | took 1173s 10:05:27 INFO - Completed test suite (00:19:33) 10:05:27 INFO - javascript benchmark 10:05:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7438.232972524616, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.7060029297218, 3134.686531346867, 3162.1146079097853, 3164.3196712706763, 3178.936421271576, 5415.783368665254, 5463.207834863947, 5465.262189604402, 5490.313710786152, 5518.006758783417, 5328.733563321838, 5349.117395629716, 5429.4570542945685, 5484.670919744808, 5531.557475401968, 4899.387576552922, 4927.063857866994, 5055.9747201263945, 5097.158968770148, 5141.280220769096, 739.1014615433103, 4994.275830004647, 5052.0906236877345, 5071.163258062434, 5115.641905066647, 4991.6256280778725, 4992.650514463989, 5009.173486374744, 5010.273510340999, 5064.987002599495, 4939.950600493985, 5030.4215015272985, 5037.798488060474, 5041.521055499722, 5056.443791182967, 4916.754162291871, 4957.950420495785, 4961.826336078256, 4964.05682920244, 5004.674696144775, 5441.809536666197, 5450.809221677262, 5451.209574611698, 5458.863528411782, 5533.114701647717, 5700.087985922274, 5834.737436815353, 5872.941270587282, 5896.557758168112, 5906.26171728534, 5945.970270148665, 5959.672218028007, 5969.791057313017, 5987.311459182206, 6029.246344206974, 5500.202470641734, 5502.339719233718, 5530.668159910378, 5537.529310008614, 5547.5007249347345, 5754.280714910637, 5941.465268125889, 5975.40245975399, 5986.7904623338845, 6003.549733769984, 5753.050746626844, 5760.798372056958, 5774.2782152230975, 5787.594868359174, 5804.361520232771, 5848.2689663792025, 5854.063349864001, 5855.765769369177, 5858.355580886185, 5872.530197584183, 5657.321121465368, 5805.158252053513, 5863.384344643836, 5905.616134951214, 5912.408759124053, 5617.073182924772, 5700.367829804189, 5749.68376739275, 5764.654120752768, 5922.644641321448, 4470.530594287618, 4476.865694029184, 4487.932681009787, 4495.393121928563, 4516.661250406232, 3926.9803650982135, 3968.444417781513, 3992.48097747291, 4009.578994205625, 4011.097503061788, 5559.63862348946, 5603.7758489659955, 5651.632643878134, 5667.886642267132, 5685.3177618685195, 5721.713914304268, 5870.090136028923, 5920.0, 5926.555508336892, 5928.703564821742, 5550.195221692913, 5585.441455854463, 5591.0, 5600.383957764642, 5641.52047075995, 5078.771455284521, 5088.72012039334, 5099.311592934981, 5129.769160387791, 5155.819546315861, 5901.852453688606, 6014.849628759316, 6098.207233059763, 6114.205153330038, 6118.877622447615, 5849.88300233993, 5871.2073870027, 5921.703914804157, 5949.137375080502, 5954.493868021266, 6048.576599637983, 6093.634381937098, 6094.116353128683, 6100.847478813065, 6119.908201376894, 5665.971670141623, 5746.683932383759, 5748.827535173951, 5818.709064546841, 5830.650160990354, 5829.737661805144, 5895.174675545341, 5924.555658325729, 5932.2584676915385, 5961.7615295387695, 5664.320281566073, 5689.118186681071, 5711.914321285267, 5719.599628026164, 5726.370099288992, 5572.860678482908, 5657.32112146545, 5691.715414229355, 5704.344000440003, 5717.22817419643, 5417.756200970887, 5565.805196818092, 5613.88772224545, 5629.437056294338, 5671.432856714296, 5721.5136713379825, 5806.506446952057, 5829.795957141479, 5846.327672317738, 5855.3266374367495, 5485.533729633026, 5558.110702287615, 5606.383297837317, 5629.605927585029, 5714.085746280575], "value": 5377.202728334735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.5392662833048, 612.5038718637903, 636.5162476517845, 640.6956695569608, 644.2140588482054, 41819.58180418195, 43133.0, 43386.56613433869, 46346.07307853841, 46394.0, 44651.0, 44840.551594484044, 45097.0, 45157.77421112898, 45544.31683524742, 8916.063813299592, 9003.639854405816, 9064.954675226614, 9065.773355666128, 9070.229030532413, 8876.644934202624, 8975.596098175565, 8976.506292153928, 8976.685815996441, 8977.910220897806, 8924.910750892506, 8950.462972221654, 9036.50299233542, 9064.592093355815, 9084.909150908505, 8974.41666291689, 8996.910030899706, 9013.639454421815, 9015.954920225422, 9016.098390160996, 8944.776380590472, 8948.776280592972, 8989.056149104315, 8998.865017024684, 9026.052264512196, 42672.78663606693, 43045.78477107626, 43083.56916430827, 43113.784431077955, 43124.56875431237, 3555.6622120898473, 3602.171500554861, 3849.8845034649007, 3955.3078211312904, 4063.1061166543313, 30063.398732025238, 31754.682453175636, 31982.520262196085, 32613.184670383194, 33486.162845928804, 4352.434183556149, 4356.281213599752, 4380.3210502372185, 4489.6408287336935, 4551.817927282905, 364849.0, 365067.0, 366201.0, 366543.0, 370605.0, 55615.49730262148, 55688.72155639196, 55959.44040559542, 56046.71976640172, 56073.43926560682, 34998.47502287468, 35748.642513575054, 35910.8204458976, 37951.81024094862, 37987.620123798406, 17739.73390399145, 17892.46322610324, 17980.460586182435, 17988.2804687811, 17989.460316190536, 13187.868121318856, 13192.802107968388, 13299.401526931118, 13301.93349033268, 13305.93347033278, 19075.427737167905, 19106.0, 19120.41874346973, 19221.61556768885, 19342.129604167563, 7045.859082818315, 7109.395701365442, 7143.89284160738, 7204.891926621105, 7279.344858962613, 953.4517652349926, 1023.4268809466722, 1029.505837198149, 1112.5536802157164, 1126.3692332293942, 32217.51673724896, 32649.183770405456, 32744.508832367534, 32794.0, 32937.17657058545, 1107.7729065541544, 1114.7436089699252, 1128.4075860173311, 1128.7178205448638, 1198.8261702053153, 17077.0, 17257.223424945656, 17283.481495555152, 17285.56786080358, 17330.0, 614872.0, 619267.0, 623564.0, 624199.0, 627030.0, 56397.15404268939, 57092.429075708715, 57143.0, 57461.0, 57512.42487575071, 1327.157255142991, 1346.582559406587, 1366.4943970730894, 1370.2532119994628, 1378.7518246715488, 30405.391892162475, 31870.52194217042, 32394.83802580972, 32425.35149297048, 32650.0, 50068.0, 50295.748521258625, 50542.74728626334, 50587.24119138142, 50747.746261268454, 498021.0, 505320.0, 505447.0, 506589.0, 506980.0, 26820.329491762863, 26927.192184234504, 27079.0, 27091.72908270892, 27151.185464436097, 46624.06751865012, 46853.29720054134, 47160.58518244458, 48275.517244827104, 48487.27269090896, 40057.79971100126, 40154.799226003684, 40374.19251614893, 40692.593074070064, 41089.58910410858, 39909.401358979056, 40698.59301406948, 40734.79632601818, 41042.58957410388, 41340.1731965353, 39566.802165988986, 40143.19355628945, 41022.79488602538, 41286.1742765149, 44298.0, 33551.49672754862, 36853.0, 36976.81511592425, 37375.813120934225, 37456.25087498289, 28033.719662803112, 28730.684052056135, 28749.56875646909, 28960.710392896643, 29013.129606111852], "value": 20207.32501356674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.2813474734872, 387.9844806207752, 392.6583872031332, 395.8416633346661, 417.04288657530964, 13961.511347102853, 15084.698306033873, 17618.91190544047, 19050.809491905078, 19167.52081197969, 15749.448769293078, 16085.356585736556, 18121.728174077365, 18441.53896152597, 18556.721649175273, 5576.33084029916, 5751.338596061444, 5760.049591817345, 5834.854128646796, 5842.853928651796, 5483.341998960111, 5756.654600723949, 5759.3376761672525, 5790.884182316351, 5799.420057994209, 5680.318361796591, 5715.5427565794635, 6633.170853643294, 7016.649167541628, 7021.75423860165, 6942.132233470817, 7023.89464158038, 7111.217766045731, 7504.399648028199, 7505.474616776828, 6984.4412447004115, 7181.174164970991, 7207.135143782727, 7234.891476627855, 7260.439005613765, 23823.523529529313, 23912.0, 24593.87703061473, 25111.497770044498, 25299.747002529923, 2265.6261716816707, 2343.7539058398793, 2524.823262371635, 2560.423904621445, 2828.9957065241956, 15454.304556294994, 15539.611509712347, 15723.13522756248, 15769.132697701622, 16162.353505859752, 2078.7505499340023, 2079.688046792978, 2081.510844951435, 2146.647731519555, 2193.3419974007734, 72263.63868180678, 74748.25251747467, 77537.61231193865, 95813.0, 98591.0, 16086.83913160877, 17482.912585437247, 17510.474685759447, 17557.297708091533, 17864.91067544654, 30450.84774576113, 30497.0, 30506.84746576253, 31012.53481197784, 31023.379532409224, 9780.364276322016, 10389.0, 10429.21780866438, 10438.425886576311, 10475.214358923111, 8844.911550884537, 8858.955705221433, 8873.334499912404, 8943.195112439911, 8993.190612844875, 8792.164744349277, 8802.515861627544, 9029.683961061332, 9045.909540904639, 9102.86345704815, 3361.411752943274, 3513.209527856263, 3524.524189234472, 3583.211693427442, 3585.8386372613295, 879.2043200903192, 1033.3128469567803, 1040.167865707431, 1081.2269227502375, 1104.5913012185542, 18543.35098271554, 18870.52823679419, 19054.52363690891, 19220.135093920806, 19456.22175113008, 981.4307701533094, 985.8028394321165, 1008.1380419741163, 1043.4834756795435, 1059.8251288537306, 10394.0, 10761.363749415541, 10822.842801370547, 10848.945755271174, 10936.398498082683, 455688.0, 464365.0, 525287.0, 529740.0, 532372.0, 63343.36656633467, 86899.0, 87018.56490717632, 93078.0, 96881.0, 1021.8620486234412, 1048.4233671480656, 1055.762453447968, 1070.8447275145215, 1073.9570417183381, 16646.583835404213, 16961.830381696025, 17172.828271717124, 17452.0, 17651.0, 41337.79331103325, 41412.378814318414, 41414.37878431886, 41586.792066039474, 43070.35394469148, 57073.71463142658, 58986.0, 60868.695656521435, 61427.385726143955, 61795.382046178966, 8156.306713929383, 8300.08699043117, 8388.832223355377, 8473.5339556325, 8710.0, 10014.449205293779, 11757.882421175678, 12827.42276597574, 12898.0, 13002.08985371015, 11017.83473247886, 11447.599334023269, 11700.414979251174, 11709.121815863675, 11815.232009919328, 11396.715082123013, 11474.311541307548, 11606.825897611374, 11626.53493860236, 11971.10216733731, 8798.34012449056, 11358.60244891425, 11404.771904562029, 11465.484053217791, 11730.826917308543, 8083.878741818995, 8118.0, 8221.54781487024, 8273.875891861748, 8320.958395207985, 10764.138868890313, 11002.779944401227, 11246.325220486797, 11304.604338848101, 11550.480228389575], "value": 10182.183187868253, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.1592584264047, 1475.9483418080365, 1513.9318730657126, 1597.8322276161002, 1637.7215873301539, 7795.883061754078, 8169.346452283803, 8356.83286334273, 8869.42348747331, 8891.244244239238, 8280.792980175484, 8455.239028487435, 8555.828883422344, 8638.0, 8659.134086591337, 2267.1951457232694, 2325.2907863101746, 2326.7091613548305, 2336.0889253191267, 2346.155384061736, 2319.7332306784683, 2329.8136149108113, 2347.9765202348012, 2360.1385494294545, 2361.2916125162383, 2269.909203631853, 2276.7837055479786, 2283.9200627978025, 2294.19703103914, 2294.7819957104134, 2198.923037693681, 2238.0600147937826, 2239.6864438978555, 2240.2271216430386, 2256.435891027243, 2304.585174668559, 2334.159702507096, 2350.3536527455085, 2360.138549429463, 2360.7875291223872, 8569.871451928226, 8687.305015598737, 8688.522131282776, 8696.17386348296, 8716.302695784321, 5214.791408343662, 5364.409914909357, 5366.060939335601, 5370.409254981949, 5395.730213489349, 3347.1799409144674, 3356.8992930212135, 3398.660133986606, 3508.8070156141403, 3521.3309471200646, 1179.958701445454, 1180.7815554122515, 1206.3485717712424, 1220.7436438347956, 1220.9145359824815, 12171.817422738666, 12183.32991685457, 12185.147039707224, 12261.570845020471, 12308.446119924625, 4611.423572053493, 4636.4899861015265, 4743.952560474351, 4744.928826067612, 4753.904921901542, 10368.0, 10403.53184106717, 10437.373757574569, 10440.68677939663, 10456.634017809492, 5360.490753378423, 5398.541124004503, 5407.486288802557, 5416.268803711528, 5433.673979561239, 4340.110277393127, 4645.140648979949, 4781.545753153445, 4800.807967681254, 4886.95113048865, 4063.756174629532, 4077.327241005201, 4106.488626781959, 4110.958890411118, 4141.834326626901, 1238.8389509363726, 1249.2192379762648, 1268.2770820632152, 1271.5613113475836, 1284.8650891656428, 1000.214831357381, 1014.8883622801634, 1017.0033367300088, 1026.7843752811993, 1028.547439126782, 6015.699215039231, 6286.182796236551, 6305.306416294204, 6338.207724034496, 6412.2625898022325, 441.6466826538756, 449.05249922663154, 451.93898823659043, 456.7236821722876, 460.9539046095364, 4410.911781764346, 4444.799984000728, 4455.0, 4472.08322293929, 4479.843205487792, 10605.310654807412, 10945.616903408501, 10950.726231844268, 10974.561017559368, 10997.560097596166, 10300.0, 10718.571257149626, 10774.676759697222, 11081.778364432666, 11091.389973551371, 7804.921950780533, 7942.126366099725, 7945.801354966172, 7955.482893612012, 7984.001999750031, 6162.784302549389, 6408.0, 6538.280789113099, 6574.342565743387, 6608.306127856506, 9826.361286516354, 10304.072633463024, 10348.948255258676, 10406.791864162826, 10419.479026048515, 10144.54349554257, 10311.845322320021, 10522.526486308288, 10545.525451354553, 10595.523201455799, 7631.656575454229, 8250.628721707657, 8328.750137495885, 8407.663693452194, 8444.451110677786, 8590.398672092893, 8629.913700862911, 8630.697925572575, 8652.826943461221, 8710.956445217733, 7591.3547348475995, 7776.533407995538, 7794.142644309235, 7857.174996625272, 7887.092984306878, 7530.924690753022, 7565.130010048915, 7567.508111972704, 7627.656755445907, 7780.92219077802, 6960.8955865663065, 7126.821829454305, 7148.28517148281, 7148.606826624377, 7159.964200178966, 5296.364436267672, 5443.482869127427, 5458.044842152528, 5547.389787123332, 5603.467670571289, 5502.378002477938, 5569.777208911598, 5571.247881535941, 5579.972100139474, 5634.070378387521], "value": 4614.76357294282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.1027165024532, 332.9495441880866, 333.9448990916499, 336.92756057447644, 337.9104537297617, 5554.305711786027, 5556.194351818989, 5564.527015203713, 5585.776568937237, 5617.7752889884405, 5408.486193811582, 5494.450554944514, 5496.615236933406, 5504.4770746779095, 5521.558275337973, 4231.428757117796, 4259.297215959363, 4321.94112442452, 4365.694401391904, 4382.802773875183, 4233.470816147981, 4279.2083464559155, 4314.158739045887, 4328.3074708046715, 4372.338511365677, 4261.616454519108, 4276.6101017169385, 4340.240457919867, 4365.738055716652, 4398.318260669601, 4150.58494150584, 4164.5210800758, 4326.913461730779, 4338.197433474786, 4378.430803995476, 3774.792386418746, 3790.431435284702, 3800.365842687643, 3805.6004119567324, 3807.695384369244, 5403.432639572828, 5403.621746477748, 5419.0, 5454.61817672763, 5455.399906010336, 4804.495527969548, 4972.726500042496, 4980.5019498049905, 4988.501149885019, 5013.420772456664, 5792.4497172768515, 5813.854653633651, 5828.2131912191735, 5828.41715828418, 5851.590388672795, 4242.0, 4249.3413520904305, 4254.361845723166, 4261.275583150872, 4265.829366825324, 5769.653820770725, 5988.880222395528, 6037.607555508878, 6095.847603809896, 6141.692915354259, 4159.542450330461, 4160.188763191149, 4193.5387107418155, 4222.21888950539, 4224.78876056196, 4250.427341883523, 4253.213155566168, 4274.508431530414, 4277.1873344064525, 4281.143771245764, 4737.8104875805275, 4878.658493905393, 4912.04215178044, 4921.630877684188, 4959.404871415381, 5874.50066744323, 5882.294124704978, 5915.822525324247, 5920.230370051866, 5920.851978700567, 1446.7395868743727, 1461.1087236785552, 1468.3539242733164, 1487.2043456750587, 1490.5528341497507, 915.0580882462914, 938.591712605019, 948.796008858085, 950.6387572722322, 950.7924935332089, 5054.191329387354, 5108.952664703726, 5117.8464646060675, 5120.334356533701, 5184.585233181412, 5292.8355761732355, 5386.8383948481605, 5412.864678383072, 5441.183822426668, 5459.426760190202, 5123.923141152885, 5181.896362072813, 5433.157860531624, 5721.542276617861, 5727.627704199213, 3200.455922493182, 3207.957413840511, 3215.807051576866, 3225.5806745123455, 3229.515572664119, 6040.214772079689, 6194.783182588588, 6217.0, 6217.906731399033, 6234.812955611339, 5996.460318571262, 6079.0, 6104.938950610437, 6134.883465204497, 6139.662318572521, 6219.40915613016, 6224.439800417984, 6258.968705156445, 6264.310925798159, 6268.592541484698, 5865.4134586541, 6001.2498437695285, 6036.788712395045, 6041.728122234598, 6073.240844894388, 5962.55280853929, 5991.310999235144, 6005.489533389711, 6007.279126504847, 6066.393360663898, 6030.879382412415, 6283.528735344776, 6298.244210694563, 6309.0, 6325.146105275913, 4156.625903668684, 4193.706440549132, 4208.431861698754, 4213.241616508935, 4252.851730032936, 6002.849928751816, 6032.487238584769, 6071.423214794588, 6076.784643071315, 6106.603070800384, 5726.599138060295, 5749.511291540266, 5871.794487192928, 5877.706114694162, 5912.379200183918, 5719.8570035749435, 5754.6547207167705, 5788.479036886701, 5828.417158284137, 5879.530117470632, 5138.897222055463, 5766.971165144148, 5801.970990145022, 5808.273965754281, 5823.534117270524, 5887.61730487517, 5894.0, 5916.934951708734, 5921.348651648229, 5923.555733319932, 5738.1679656450415, 5779.190913272229, 5803.665157013826, 5827.455724233167, 5861.443162899518], "value": 4413.26164729606, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.0324581290135, 778.5873487051861, 789.2659826361485, 789.3645615279697, 793.8531371696234, 17246.0, 17859.464216073506, 17934.910325448356, 17994.91002544987, 18013.549661258476, 16841.41055063073, 16871.24079416426, 16974.745378819327, 17038.914805425986, 17042.0, 670.7819958513478, 820.4011071917504, 820.409305300183, 820.659426338072, 823.1644880446352, 795.3001358804244, 828.7306625346756, 831.7005877883956, 832.9708460203894, 833.170994860115, 858.2618947704968, 867.8177582707639, 869.5565261716507, 870.8824308718337, 871.1375738019346, 858.5964596639569, 864.4165188497739, 864.4337958637103, 864.7924498120437, 865.8441480533502, 623.8440389902524, 624.1511544299749, 624.3101372982834, 628.2084573437456, 629.6316654756972, 14457.566273011826, 14520.0, 14523.78214326786, 14536.491222807152, 14572.635684107876, 14446.927765361106, 14507.854921450757, 14577.0, 14638.560843174722, 14722.337494812651, 11839.704007399798, 11965.282083075042, 12026.098042646836, 12071.275723456622, 12103.334316612583, 3703.3148867459336, 3876.0116170376655, 3941.0147463134217, 3947.684185265172, 3957.5053118360206, 71197.28802711959, 72492.27507724908, 72540.99999999948, 72795.0, 74855.25144748537, 11099.38953357557, 11155.498002589902, 11169.497372618089, 11289.37908415045, 11666.300021998537, 20674.483137921674, 20766.58466830655, 20933.476663083544, 20983.79016209849, 21000.579988400452, 8307.08622051574, 8396.0, 8461.238488535939, 8488.872666910001, 8529.786755331166, 4713.835015774432, 4716.8113275468595, 4848.5636292733825, 4908.11653902301, 4965.428975667773, 3462.9826850865584, 3548.432250839905, 3567.2152126532123, 3571.196480791853, 3591.3894637911617, 520.9947900521022, 624.6595605395071, 638.2946843737695, 640.1390130274866, 640.782134074417, 676.7293082766932, 694.6665600511682, 714.1893950366372, 721.8917162425573, 724.9275072492813, 9925.30522863407, 9985.20118390527, 10011.899881001096, 10103.141232995278, 10135.695929122137, 613.5122577550858, 656.1306269193337, 675.5676367125044, 684.5447777228187, 689.3072462175481, 4312.37470566766, 4517.683762136685, 4538.804531814116, 4696.436427628706, 4705.60002399793, 92556.53721731348, 95605.0, 110022.44988775004, 118419.0, 118683.0, 60633.0, 82312.76530852042, 87581.68627470593, 97374.0, 97462.0, 57252.0, 63954.040689389694, 83931.58034209911, 84400.0, 90167.0, 9362.103174603175, 9372.625094996123, 9527.761805954906, 9609.56756945953, 9618.182454491447, 48093.75953120212, 48224.0, 48422.0, 48991.0, 49760.25359619681, 74174.51650967059, 75848.0, 78425.60787196028, 78890.21109788828, 79487.0, 12631.589435977645, 12734.936325318315, 12755.48978040868, 12942.223466592035, 12985.766352196526, 14248.786268206193, 14420.206888621227, 14876.925615372287, 15062.32219550101, 15268.160251185847, 12552.686182845136, 13618.931905340807, 13648.863511365156, 13901.51344702971, 14612.269386530843, 12988.935055324662, 13180.406881690538, 13192.142510736772, 13383.665408364868, 14160.645983850074, 12176.756464870476, 13199.406026728628, 13303.86696133065, 13648.590542283748, 13863.0, 10484.685459436228, 10527.894721052691, 11087.22389432732, 11950.521979120738, 12076.51693932268, 10712.571497140027, 10849.566017359217, 11918.52325906954, 11993.280403175837, 12073.698157546132], "value": 7515.510827037399, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 109.0, 111.0, 112.0, 111.0, 110.0, 110.0, 110.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 158.0, 177.0, 129.0, 154.0, 151.0, 130.0, 181.0, 130.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 165.0, 173.0, 161.0, 162.0, 163.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 159.0, 77.0, 76.0, 75.0, 75.0, 170.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 165.0, 86.0, 84.0, 85.0, 135.0, 85.0, 85.0, 157.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 149.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 55.0, 56.0, 55.0, 55.0, 55.0, 57.0, 68.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 62.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 79.0, 85.0, 84.0, 80.0, 80.0, 81.0, 106.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 130.0, 131.0, 121.0, 127.0, 126.0, 132.0, 127.0, 134.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 164.0, 163.0, 164.0, 166.0, 160.0, 159.0, 169.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 63.0, 64.0, 65.0, 63.0, 63.0, 64.0, 64.0, 68.0], "value": 64.6, "unit": "score"}]}]} 10:05:27 INFO - Return code: 0 10:05:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:05:27 ERROR - # TBPL SUCCESS # 10:05:27 INFO - Running post-action listener: _resource_record_post_action 10:05:27 INFO - ##### 10:05:27 INFO - ##### Finished run-tests step (success) 10:05:27 INFO - ##### 10:05:27 INFO - Running post-run listener: _resource_record_post_run 10:05:27 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547692544; Read time: 12; Write time: 736940 10:05:27 INFO - TinderboxPrint: CPU usage
13.5% 10:05:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:05:27 INFO - TinderboxPrint: I/O write bytes / time
547,692,544 / 736,940 10:05:27 INFO - TinderboxPrint: CPU idle
8,225.8 (86.5%) 10:05:27 INFO - TinderboxPrint: CPU user
1,220.8 (12.8%) 10:05:27 INFO - TinderboxPrint: Swap in / out
0 / 0 10:05:27 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 254820352; Read time: 0; Write time: 428920 10:05:27 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292868096; Read time: 12; Write time: 308020 10:05:28 INFO - Running post-run listener: _upload_blobber_files 10:05:28 INFO - Blob upload gear active. 10:05:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:05:28 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:05:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:05:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:32 INFO - (blobuploader) - INFO - Done attempting. 10:05:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:05:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:05:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:33 INFO - (blobuploader) - INFO - Done attempting. 10:05:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:05:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:05:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:34 INFO - (blobuploader) - INFO - Done attempting. 10:05:34 INFO - (blobuploader) - INFO - Iteration through files over. 10:05:34 INFO - Return code: 0 10:05:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:05:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:05:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/320a44645a7025a7754d41c62221dc455e4ea3bb8dd426c26fbfd637d59f4c3459cdb1c67f27928de73bc967e98d08f1f54ee3025162cdd8bdbd9bfa242d4c09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ea4487826380b4895211792cdb7b042954546641e8be01faa7aa09a66aa2986d7296b74e03592ad3f49ad20541a6f0290e450564014e9c95744889b68f7aec5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b072b402619f23a0c28d999accb1dfd68b0f8d9d1f506feb2d6813915ef12009432710e7f89babd5ebf47b13e7fdc52696f556d8e0ef7833fec63615ac6bf208"} 10:05:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:05:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:05:34 INFO - Contents: 10:05:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/320a44645a7025a7754d41c62221dc455e4ea3bb8dd426c26fbfd637d59f4c3459cdb1c67f27928de73bc967e98d08f1f54ee3025162cdd8bdbd9bfa242d4c09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ea4487826380b4895211792cdb7b042954546641e8be01faa7aa09a66aa2986d7296b74e03592ad3f49ad20541a6f0290e450564014e9c95744889b68f7aec5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b072b402619f23a0c28d999accb1dfd68b0f8d9d1f506feb2d6813915ef12009432710e7f89babd5ebf47b13e7fdc52696f556d8e0ef7833fec63615ac6bf208"} 10:05:34 INFO - Running post-run listener: copy_logs_to_upload_dir 10:05:34 INFO - Copying logs to upload dir... 10:05:34 INFO - mkdir: /builds/slave/test/build/upload/logs 10:05:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.547336 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-09 10:05:34.379928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 10:05:34.383746) ========= 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=32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/320a44645a7025a7754d41c62221dc455e4ea3bb8dd426c26fbfd637d59f4c3459cdb1c67f27928de73bc967e98d08f1f54ee3025162cdd8bdbd9bfa242d4c09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ea4487826380b4895211792cdb7b042954546641e8be01faa7aa09a66aa2986d7296b74e03592ad3f49ad20541a6f0290e450564014e9c95744889b68f7aec5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b072b402619f23a0c28d999accb1dfd68b0f8d9d1f506feb2d6813915ef12009432710e7f89babd5ebf47b13e7fdc52696f556d8e0ef7833fec63615ac6bf208"} build_url:https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/Ua0pNU8KQkCyx03zP_CCQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/320a44645a7025a7754d41c62221dc455e4ea3bb8dd426c26fbfd637d59f4c3459cdb1c67f27928de73bc967e98d08f1f54ee3025162cdd8bdbd9bfa242d4c09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ea4487826380b4895211792cdb7b042954546641e8be01faa7aa09a66aa2986d7296b74e03592ad3f49ad20541a6f0290e450564014e9c95744889b68f7aec5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b072b402619f23a0c28d999accb1dfd68b0f8d9d1f506feb2d6813915ef12009432710e7f89babd5ebf47b13e7fdc52696f556d8e0ef7833fec63615ac6bf208"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 10:05:34.409383) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 10:05:34.409714) ========= 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=32c5991c409366f7fec8a718000001d2-1465490698.186366-305864182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 10:05:34.496538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 10:05:34.496922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 10:05:34.497317) ========= ========= Total master_lag: 0.17 =========