builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1466529505.43 results: success (0) buildid: 20160621090403 builduid: 7043c62a1939484dae1a8f348df32da4 revision: 7fb69043ac05ed4c505a4a14f9c1a3130aa1715d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:25.430615) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:25.433487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:25.433807) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:25.452261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:25.452616) ========= 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=7de08804244eb36560b44971000001c3-1466528662.338014-2147016368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 10:18:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.7M=0s 2016-06-21 10:18:25 (39.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115634 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:25.585642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:25.585966) ========= 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=7de08804244eb36560b44971000001c3-1466528662.338014-2147016368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020114 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:25.637195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:25.637544) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7fb69043ac05ed4c505a4a14f9c1a3130aa1715d --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 7fb69043ac05ed4c505a4a14f9c1a3130aa1715d --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=7de08804244eb36560b44971000001c3-1466528662.338014-2147016368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 10:18:25,681 truncating revision to first 12 chars 2016-06-21 10:18:25,681 Setting DEBUG logging. 2016-06-21 10:18:25,681 attempt 1/10 2016-06-21 10:18:25,681 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7fb69043ac05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 10:18:25,994 unpacking tar archive at: mozilla-central-7fb69043ac05/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686778 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:26.337877) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:26.338198) ========= script_repo_revision: 7fb69043ac05ed4c505a4a14f9c1a3130aa1715d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:26.338654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:26.338940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 10:18:26.349718) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-06-21 10:18:26.350153) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=7de08804244eb36560b44971000001c3-1466528662.338014-2147016368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:18:26 INFO - MultiFileLogger online at 20160621 10:18:26 in /builds/slave/test 10:18:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:18:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:18:26 INFO - {'append_to_log': False, 10:18:26 INFO - 'base_work_dir': '/builds/slave/test', 10:18:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:18:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:18:26 INFO - 'branch': 'Firefox-Non-PGO', 10:18:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:18:26 INFO - 'config_files': ('talos/linux_config.py',), 10:18:26 INFO - 'default_actions': ('clobber', 10:18:26 INFO - 'read-buildbot-config', 10:18:26 INFO - 'download-and-extract', 10:18:26 INFO - 'populate-webroot', 10:18:26 INFO - 'create-virtualenv', 10:18:26 INFO - 'install', 10:18:26 INFO - 'run-tests'), 10:18:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:18:26 INFO - 'download_minidump_stackwalk': True, 10:18:26 INFO - 'download_symbols': 'ondemand', 10:18:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:18:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:18:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:18:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:18:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:18:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:18:26 INFO - 'installer_path': 'installer.exe', 10:18:26 INFO - 'log_level': 'info', 10:18:26 INFO - 'log_name': 'talos', 10:18:26 INFO - 'log_to_console': True, 10:18:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:18:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:18:26 INFO - 'opt_config_files': (), 10:18:26 INFO - 'pip_index': False, 10:18:26 INFO - 'sps_profile': False, 10:18:26 INFO - 'sps_profile_interval': 0, 10:18:26 INFO - 'suite': 'dromaeojs-e10s', 10:18:26 INFO - 'system_bits': '32', 10:18:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:18:26 INFO - 'title': 'talos-linux64-ix-003', 10:18:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:18:26 INFO - 'use_talos_json': True, 10:18:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:18:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:18:26 INFO - 'work_dir': 'build'} 10:18:26 INFO - ##### 10:18:26 INFO - ##### Running clobber step. 10:18:26 INFO - ##### 10:18:26 INFO - Running pre-action listener: _resource_record_pre_action 10:18:26 INFO - Running main action method: clobber 10:18:26 INFO - rmtree: /builds/slave/test/build 10:18:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:18:26 INFO - Running post-action listener: _resource_record_post_action 10:18:26 INFO - ##### 10:18:26 INFO - ##### Finished clobber step (success) 10:18:26 INFO - ##### 10:18:26 INFO - ##### 10:18:26 INFO - ##### Running read-buildbot-config step. 10:18:26 INFO - ##### 10:18:26 INFO - Running pre-action listener: _resource_record_pre_action 10:18:26 INFO - Running main action method: read_buildbot_config 10:18:26 INFO - Using buildbot properties: 10:18:26 INFO - { 10:18:26 INFO - "project": "", 10:18:26 INFO - "product": "firefox", 10:18:26 INFO - "script_repo_revision": "production", 10:18:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:18:26 INFO - "repository": "", 10:18:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:18:26 INFO - "buildid": "20160621090403", 10:18:26 INFO - "pgo_build": "False", 10:18:26 INFO - "basedir": "/builds/slave/test", 10:18:26 INFO - "buildnumber": 352, 10:18:26 INFO - "slavename": "talos-linux64-ix-003", 10:18:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:18:26 INFO - "platform": "ubuntu64_hw", 10:18:26 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:18:26 INFO - "branch": "mozilla-central", 10:18:26 INFO - "repo_path": "mozilla-central", 10:18:26 INFO - "revision": "7fb69043ac05ed4c505a4a14f9c1a3130aa1715d", 10:18:26 INFO - "stage_platform": "linux64", 10:18:26 INFO - "builduid": "7043c62a1939484dae1a8f348df32da4", 10:18:26 INFO - "slavebuilddir": "test" 10:18:26 INFO - } 10:18:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:18:26 INFO - Running post-action listener: _resource_record_post_action 10:18:26 INFO - ##### 10:18:26 INFO - ##### Finished read-buildbot-config step (success) 10:18:26 INFO - ##### 10:18:26 INFO - ##### 10:18:26 INFO - ##### Running download-and-extract step. 10:18:26 INFO - ##### 10:18:26 INFO - Running pre-action listener: _resource_record_pre_action 10:18:26 INFO - Running main action method: download_and_extract 10:18:26 INFO - mkdir: /builds/slave/test/build/tests 10:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:26 INFO - https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:18:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:18:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:18:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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 10:18:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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 10:18:27 INFO - Downloaded 1361 bytes. 10:18:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:18:27 INFO - Using the following test package requirements: 10:18:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:18:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:18:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:27 INFO - u'jsshell-linux-x86_64.zip'], 10:18:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:18:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:18:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:18:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:18:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:18:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:27 INFO - https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:18:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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 10:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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 10:18:29 INFO - Downloaded 22658706 bytes. 10:18:29 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'] 10:18:29 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 10:18:30 INFO - Return code: 0 10:18:30 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 10:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:30 INFO - https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:18:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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 10:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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 10:18:31 INFO - Downloaded 22658706 bytes. 10:18:31 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'] 10:18:31 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 10:18:33 INFO - Return code: 0 10:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:33 INFO - https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:18:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:18:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:18:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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 10:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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 10:18:35 INFO - Downloaded 14405384 bytes. 10:18:35 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'] 10:18:35 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 10:18:35 INFO - Return code: 0 10:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:35 INFO - https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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 10:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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 10:19:04 INFO - Downloaded 56228030 bytes. 10:19:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:19:04 INFO - mkdir: /builds/slave/test/properties 10:19:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:04 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:04 INFO - Contents: 10:19:04 INFO - build_url:https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:19:05 INFO - Running post-action listener: _resource_record_post_action 10:19:05 INFO - Running post-action listener: set_extra_try_arguments 10:19:05 INFO - ##### 10:19:05 INFO - ##### Finished download-and-extract step (success) 10:19:05 INFO - ##### 10:19:05 INFO - ##### 10:19:05 INFO - ##### Running populate-webroot step. 10:19:05 INFO - ##### 10:19:05 INFO - Running pre-action listener: _resource_record_pre_action 10:19:05 INFO - Running main action method: populate_webroot 10:19:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:05 INFO - '--tppagecycles', 10:19:05 INFO - '7'], 10:19:05 INFO - 'tests': ['tsvgm']}}, 10:19:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['damp', 'tps']}, 10:19:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'tests': ['damp', 'tps']}, 10:19:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['dromaeo_dom']}, 10:19:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['basic_compositor_video']}, 10:19:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:19:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['tsvgx', 10:19:05 INFO - 'tsvgr_opacity', 10:19:05 INFO - 'tart', 10:19:05 INFO - 'tscrollx', 10:19:05 INFO - 'cart']}, 10:19:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:05 INFO - 'tsvgr_opacity', 10:19:05 INFO - 'tart', 10:19:05 INFO - 'tscrollx', 10:19:05 INFO - 'cart']}, 10:19:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['tp5o']}, 10:19:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'tests': ['tp5o']}, 10:19:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'talos_options': ['--disable-e10s', 10:19:05 INFO - '--xperf_path', 10:19:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:05 INFO - 'tests': ['tp5n']}, 10:19:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'talos_options': ['--xperf_path', 10:19:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:05 INFO - 'tests': ['tp5n']}}, 10:19:05 INFO - 'talos.zip': {'path': '', 10:19:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:05 INFO - Running post-action listener: _resource_record_post_action 10:19:05 INFO - ##### 10:19:05 INFO - ##### Finished populate-webroot step (success) 10:19:05 INFO - ##### 10:19:05 INFO - ##### 10:19:05 INFO - ##### Running create-virtualenv step. 10:19:05 INFO - ##### 10:19:05 INFO - Running pre-action listener: _resource_record_pre_action 10:19:05 INFO - Running main action method: create_virtualenv 10:19:05 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:19:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:05 INFO - Using real prefix '/usr' 10:19:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:05 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:08 INFO - Installing pip.................done. 10:19:08 INFO - Return code: 0 10:19:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:08 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 0x7effe04c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, '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': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:19:08 INFO - Using env: {'DISPLAY': ':0', 10:19:08 INFO - 'HOME': '/home/cltbld', 10:19:08 INFO - 'LANG': 'en_US.UTF-8', 10:19:08 INFO - 'LANGUAGE': 'en_US:en', 10:19:08 INFO - 'LOGNAME': 'cltbld', 10:19:08 INFO - 'MAIL': '/var/mail/cltbld', 10:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:08 INFO - 'MOZ_NO_REMOTE': '1', 10:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:08 INFO - 'NO_EM_RESTART': '1', 10:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:08 INFO - 'PWD': '/builds/slave/test', 10:19:08 INFO - 'SHELL': '/bin/bash', 10:19:08 INFO - 'SHLVL': '1', 10:19:08 INFO - 'TERM': 'linux', 10:19:08 INFO - 'TMOUT': '86400', 10:19:08 INFO - 'USER': 'cltbld', 10:19:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:08 INFO - '_': '/tools/buildbot/bin/python'} 10:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:19:08 INFO - Cleaning up... 10:19:08 INFO - Return code: 0 10:19:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:08 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 0x7effe04c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, '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': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:19:08 INFO - Using env: {'DISPLAY': ':0', 10:19:08 INFO - 'HOME': '/home/cltbld', 10:19:08 INFO - 'LANG': 'en_US.UTF-8', 10:19:08 INFO - 'LANGUAGE': 'en_US:en', 10:19:08 INFO - 'LOGNAME': 'cltbld', 10:19:08 INFO - 'MAIL': '/var/mail/cltbld', 10:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:08 INFO - 'MOZ_NO_REMOTE': '1', 10:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:08 INFO - 'NO_EM_RESTART': '1', 10:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:08 INFO - 'PWD': '/builds/slave/test', 10:19:08 INFO - 'SHELL': '/bin/bash', 10:19:08 INFO - 'SHLVL': '1', 10:19:08 INFO - 'TERM': 'linux', 10:19:08 INFO - 'TMOUT': '86400', 10:19:08 INFO - 'USER': 'cltbld', 10:19:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:08 INFO - '_': '/tools/buildbot/bin/python'} 10:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:08 INFO - Downloading/unpacking psutil>=3.1.1 10:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:10 INFO - Installing collected packages: psutil 10:19:10 INFO - Running setup.py install for psutil 10:19:10 INFO - building 'psutil._psutil_linux' extension 10:19:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:19:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:19:10 INFO - building 'psutil._psutil_posix' extension 10:19:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:19:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:19:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:11 INFO - Successfully installed psutil 10:19:11 INFO - Cleaning up... 10:19:11 INFO - Return code: 0 10:19:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:11 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 0x7effe04c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, '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': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:19:11 INFO - Using env: {'DISPLAY': ':0', 10:19:11 INFO - 'HOME': '/home/cltbld', 10:19:11 INFO - 'LANG': 'en_US.UTF-8', 10:19:11 INFO - 'LANGUAGE': 'en_US:en', 10:19:11 INFO - 'LOGNAME': 'cltbld', 10:19:11 INFO - 'MAIL': '/var/mail/cltbld', 10:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:11 INFO - 'MOZ_NO_REMOTE': '1', 10:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:11 INFO - 'NO_EM_RESTART': '1', 10:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:11 INFO - 'PWD': '/builds/slave/test', 10:19:11 INFO - 'SHELL': '/bin/bash', 10:19:11 INFO - 'SHLVL': '1', 10:19:11 INFO - 'TERM': 'linux', 10:19:11 INFO - 'TMOUT': '86400', 10:19:11 INFO - 'USER': 'cltbld', 10:19:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:11 INFO - '_': '/tools/buildbot/bin/python'} 10:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:19:13 INFO - Installing collected packages: mozsystemmonitor 10:19:13 INFO - Running setup.py install for mozsystemmonitor 10:19:13 INFO - Successfully installed mozsystemmonitor 10:19:13 INFO - Cleaning up... 10:19:13 INFO - Return code: 0 10:19:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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', '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 0x7effe04c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, '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': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:19: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 jsonschema==2.5.1 10:19:13 INFO - Using env: {'DISPLAY': ':0', 10:19:13 INFO - 'HOME': '/home/cltbld', 10:19:13 INFO - 'LANG': 'en_US.UTF-8', 10:19:13 INFO - 'LANGUAGE': 'en_US:en', 10:19:13 INFO - 'LOGNAME': 'cltbld', 10:19:13 INFO - 'MAIL': '/var/mail/cltbld', 10:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:13 INFO - 'MOZ_NO_REMOTE': '1', 10:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:13 INFO - 'NO_EM_RESTART': '1', 10:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:13 INFO - 'PWD': '/builds/slave/test', 10:19:13 INFO - 'SHELL': '/bin/bash', 10:19:13 INFO - 'SHLVL': '1', 10:19:13 INFO - 'TERM': 'linux', 10:19:13 INFO - 'TMOUT': '86400', 10:19:13 INFO - 'USER': 'cltbld', 10:19:13 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:13 INFO - '_': '/tools/buildbot/bin/python'} 10:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:13 INFO - Downloading/unpacking jsonschema==2.5.1 10:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:15 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:15 INFO - warning: no files found matching '*.txt' 10:19:15 INFO - no previously-included directories found matching 'build' 10:19:15 INFO - no previously-included directories found matching 'dist' 10:19:15 INFO - no previously-included directories found matching '.git*' 10:19:15 INFO - Installing collected packages: jsonschema, functools32 10:19:15 INFO - Running setup.py install for functools32 10:19:15 INFO - warning: no files found matching '*.txt' 10:19:15 INFO - no previously-included directories found matching 'build' 10:19:15 INFO - no previously-included directories found matching 'dist' 10:19:15 INFO - no previously-included directories found matching '.git*' 10:19:15 INFO - Successfully installed jsonschema functools32 10:19:15 INFO - Cleaning up... 10:19:15 INFO - Return code: 0 10:19:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:15 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 0x7effe04c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, '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': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:19:15 INFO - Using env: {'DISPLAY': ':0', 10:19:15 INFO - 'HOME': '/home/cltbld', 10:19:15 INFO - 'LANG': 'en_US.UTF-8', 10:19:15 INFO - 'LANGUAGE': 'en_US:en', 10:19:15 INFO - 'LOGNAME': 'cltbld', 10:19:15 INFO - 'MAIL': '/var/mail/cltbld', 10:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:15 INFO - 'MOZ_NO_REMOTE': '1', 10:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:15 INFO - 'NO_EM_RESTART': '1', 10:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:15 INFO - 'PWD': '/builds/slave/test', 10:19:15 INFO - 'SHELL': '/bin/bash', 10:19:15 INFO - 'SHLVL': '1', 10:19:15 INFO - 'TERM': 'linux', 10:19:15 INFO - 'TMOUT': '86400', 10:19:15 INFO - 'USER': 'cltbld', 10:19:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:15 INFO - '_': '/tools/buildbot/bin/python'} 10:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:16 INFO - Downloading/unpacking blobuploader==1.2.4 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:18 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:18 INFO - Downloading docopt-0.6.1.tar.gz 10:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:18 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:18 INFO - Running setup.py install for blobuploader 10:19:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:18 INFO - Running setup.py install for requests 10:19:19 INFO - Running setup.py install for docopt 10:19:19 INFO - Successfully installed blobuploader requests docopt 10:19:19 INFO - Cleaning up... 10:19:19 INFO - Return code: 0 10:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:19 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 0x7effe04c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, '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': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:19 INFO - Using env: {'DISPLAY': ':0', 10:19:19 INFO - 'HOME': '/home/cltbld', 10:19:19 INFO - 'LANG': 'en_US.UTF-8', 10:19:19 INFO - 'LANGUAGE': 'en_US:en', 10:19:19 INFO - 'LOGNAME': 'cltbld', 10:19:19 INFO - 'MAIL': '/var/mail/cltbld', 10:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:19 INFO - 'MOZ_NO_REMOTE': '1', 10:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:19 INFO - 'NO_EM_RESTART': '1', 10:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:19 INFO - 'PWD': '/builds/slave/test', 10:19:19 INFO - 'SHELL': '/bin/bash', 10:19:19 INFO - 'SHLVL': '1', 10:19:19 INFO - 'TERM': 'linux', 10:19:19 INFO - 'TMOUT': '86400', 10:19:19 INFO - 'USER': 'cltbld', 10:19:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:19 INFO - '_': '/tools/buildbot/bin/python'} 10:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:19 INFO - Running setup.py (path:/tmp/pip-eNUDKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:19 INFO - Running setup.py (path:/tmp/pip-08trKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:19 INFO - Running setup.py (path:/tmp/pip-urLG_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:19 INFO - Running setup.py (path:/tmp/pip-3HNcQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:19 INFO - Running setup.py (path:/tmp/pip-DJ3I2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:19 INFO - Running setup.py (path:/tmp/pip-OyzZjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:20 INFO - Running setup.py (path:/tmp/pip-zauBhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:20 INFO - Running setup.py (path:/tmp/pip-vCU387-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:20 INFO - Running setup.py (path:/tmp/pip-GV5Hqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:20 INFO - Running setup.py (path:/tmp/pip-fkyyEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:20 INFO - Running setup.py (path:/tmp/pip-N7bt6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:20 INFO - Running setup.py (path:/tmp/pip-Q363j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:20 INFO - Running setup.py (path:/tmp/pip-NqUtO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:20 INFO - Running setup.py (path:/tmp/pip-nW_1Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:20 INFO - Running setup.py (path:/tmp/pip-YdGZ2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:20 INFO - Running setup.py (path:/tmp/pip-T4TgoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:20 INFO - Running setup.py (path:/tmp/pip-Dw3N36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:20 INFO - Running setup.py install for manifestparser 10:19:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Running setup.py install for mozcrash 10:19:21 INFO - Running setup.py install for mozdebug 10:19:21 INFO - Running setup.py install for mozdevice 10:19:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozfile 10:19:21 INFO - Running setup.py install for mozhttpd 10:19:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozinfo 10:19:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozInstall 10:19:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozleak 10:19:21 INFO - Running setup.py install for mozlog 10:19:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for moznetwork 10:19:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozprocess 10:19:22 INFO - Running setup.py install for mozprofile 10:19:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:22 INFO - Running setup.py install for mozrunner 10:19:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:22 INFO - Running setup.py install for mozscreenshot 10:19:22 INFO - Running setup.py install for moztest 10:19:22 INFO - Running setup.py install for mozversion 10:19:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:22 INFO - Cleaning up... 10:19:22 INFO - Return code: 0 10:19:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:22 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 0x7effe04c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, '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': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:22 INFO - Using env: {'DISPLAY': ':0', 10:19:22 INFO - 'HOME': '/home/cltbld', 10:19:22 INFO - 'LANG': 'en_US.UTF-8', 10:19:22 INFO - 'LANGUAGE': 'en_US:en', 10:19:22 INFO - 'LOGNAME': 'cltbld', 10:19:22 INFO - 'MAIL': '/var/mail/cltbld', 10:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:22 INFO - 'MOZ_NO_REMOTE': '1', 10:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:22 INFO - 'NO_EM_RESTART': '1', 10:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:22 INFO - 'PWD': '/builds/slave/test', 10:19:22 INFO - 'SHELL': '/bin/bash', 10:19:22 INFO - 'SHLVL': '1', 10:19:22 INFO - 'TERM': 'linux', 10:19:22 INFO - 'TMOUT': '86400', 10:19:22 INFO - 'USER': 'cltbld', 10:19:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:22 INFO - '_': '/tools/buildbot/bin/python'} 10:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:22 INFO - Running setup.py (path:/tmp/pip-7WzSlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:22 INFO - Running setup.py (path:/tmp/pip-aiF5pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:23 INFO - Running setup.py (path:/tmp/pip-2xofYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:23 INFO - Running setup.py (path:/tmp/pip-vzUUqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:23 INFO - Running setup.py (path:/tmp/pip-b_JDzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:23 INFO - Running setup.py (path:/tmp/pip-KNy2ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:23 INFO - Running setup.py (path:/tmp/pip-EthnFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:23 INFO - Running setup.py (path:/tmp/pip-qlUUte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:23 INFO - Running setup.py (path:/tmp/pip-rxb1pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:23 INFO - Running setup.py (path:/tmp/pip-AsLDWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:23 INFO - Running setup.py (path:/tmp/pip-OGgh5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:23 INFO - Running setup.py (path:/tmp/pip-u_Ld9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:23 INFO - Running setup.py (path:/tmp/pip-9CMUzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:23 INFO - Running setup.py (path:/tmp/pip-VJpMXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:23 INFO - Running setup.py (path:/tmp/pip-KAICeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:23 INFO - Running setup.py (path:/tmp/pip-jm4akK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:24 INFO - Running setup.py (path:/tmp/pip-nT6LbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:25 INFO - Downloading blessings-1.6.tar.gz 10:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:26 INFO - Installing collected packages: blessings 10:19:26 INFO - Running setup.py install for blessings 10:19:26 INFO - Successfully installed blessings 10:19:26 INFO - Cleaning up... 10:19:26 INFO - Return code: 0 10:19:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:19:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:26 INFO - Reading from file tmpfile_stdout 10:19:26 INFO - Current package versions: 10:19:26 INFO - argparse == 1.2.1 10:19:26 INFO - blessings == 1.6 10:19:26 INFO - blobuploader == 1.2.4 10:19:26 INFO - docopt == 0.6.1 10:19:26 INFO - functools32 == 3.2.3-2 10:19:26 INFO - jsonschema == 2.5.1 10:19:26 INFO - manifestparser == 1.1 10:19:26 INFO - mozInstall == 1.12 10:19:26 INFO - mozcrash == 0.17 10:19:26 INFO - mozdebug == 0.1 10:19:26 INFO - mozdevice == 0.48 10:19:26 INFO - mozfile == 1.2 10:19:26 INFO - mozhttpd == 0.7 10:19:26 INFO - mozinfo == 0.9 10:19:26 INFO - mozleak == 0.1 10:19:26 INFO - mozlog == 3.2 10:19:26 INFO - moznetwork == 0.27 10:19:26 INFO - mozprocess == 0.22 10:19:26 INFO - mozprofile == 0.28 10:19:26 INFO - mozrunner == 6.11 10:19:26 INFO - mozscreenshot == 0.1 10:19:26 INFO - mozsystemmonitor == 0.3 10:19:26 INFO - moztest == 0.7 10:19:26 INFO - mozversion == 1.4 10:19:26 INFO - psutil == 3.1.1 10:19:26 INFO - requests == 1.2.3 10:19:26 INFO - wsgiref == 0.1.2 10:19:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:26 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 0x7effe04c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, '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': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:26 INFO - Using env: {'DISPLAY': ':0', 10:19:26 INFO - 'HOME': '/home/cltbld', 10:19:26 INFO - 'LANG': 'en_US.UTF-8', 10:19:26 INFO - 'LANGUAGE': 'en_US:en', 10:19:26 INFO - 'LOGNAME': 'cltbld', 10:19:26 INFO - 'MAIL': '/var/mail/cltbld', 10:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:26 INFO - 'MOZ_NO_REMOTE': '1', 10:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:26 INFO - 'NO_EM_RESTART': '1', 10:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:26 INFO - 'PWD': '/builds/slave/test', 10:19:26 INFO - 'SHELL': '/bin/bash', 10:19:26 INFO - 'SHLVL': '1', 10:19:26 INFO - 'TERM': 'linux', 10:19:26 INFO - 'TMOUT': '86400', 10:19:26 INFO - 'USER': 'cltbld', 10:19:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:26 INFO - '_': '/tools/buildbot/bin/python'} 10:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:19:26 INFO - Cleaning up... 10:19:26 INFO - Return code: 0 10:19:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:26 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 0x7effe04c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, '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': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:19:26 INFO - Using env: {'DISPLAY': ':0', 10:19:26 INFO - 'HOME': '/home/cltbld', 10:19:26 INFO - 'LANG': 'en_US.UTF-8', 10:19:26 INFO - 'LANGUAGE': 'en_US:en', 10:19:26 INFO - 'LOGNAME': 'cltbld', 10:19:26 INFO - 'MAIL': '/var/mail/cltbld', 10:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:26 INFO - 'MOZ_NO_REMOTE': '1', 10:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:26 INFO - 'NO_EM_RESTART': '1', 10:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:26 INFO - 'PWD': '/builds/slave/test', 10:19:26 INFO - 'SHELL': '/bin/bash', 10:19:26 INFO - 'SHLVL': '1', 10:19:26 INFO - 'TERM': 'linux', 10:19:26 INFO - 'TMOUT': '86400', 10:19:26 INFO - 'USER': 'cltbld', 10:19:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:26 INFO - '_': '/tools/buildbot/bin/python'} 10:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:19:26 INFO - Cleaning up... 10:19:26 INFO - Return code: 0 10:19:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:26 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 0x7effe04c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, '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': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:19:26 INFO - Using env: {'DISPLAY': ':0', 10:19:26 INFO - 'HOME': '/home/cltbld', 10:19:26 INFO - 'LANG': 'en_US.UTF-8', 10:19:26 INFO - 'LANGUAGE': 'en_US:en', 10:19:26 INFO - 'LOGNAME': 'cltbld', 10:19:26 INFO - 'MAIL': '/var/mail/cltbld', 10:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:26 INFO - 'MOZ_NO_REMOTE': '1', 10:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:26 INFO - 'NO_EM_RESTART': '1', 10:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:26 INFO - 'PWD': '/builds/slave/test', 10:19:26 INFO - 'SHELL': '/bin/bash', 10:19:26 INFO - 'SHLVL': '1', 10:19:26 INFO - 'TERM': 'linux', 10:19:26 INFO - 'TMOUT': '86400', 10:19:26 INFO - 'USER': 'cltbld', 10:19:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:26 INFO - '_': '/tools/buildbot/bin/python'} 10:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:27 INFO - Downloading/unpacking flake8 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:19:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:19:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:19:29 INFO - no previously-included directories found matching 'docs/_build' 10:19:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:19:29 INFO - Running setup.py install for pep8 10:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:19:29 INFO - no previously-included directories found matching 'docs/_build' 10:19:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:19:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:19:29 INFO - Cleaning up... 10:19:30 INFO - Return code: 0 10:19:30 INFO - Running post-action listener: _resource_record_post_action 10:19:30 INFO - Running post-action listener: _start_resource_monitoring 10:19:30 INFO - Starting resource monitoring. 10:19:30 INFO - ##### 10:19:30 INFO - ##### Finished create-virtualenv step (success) 10:19:30 INFO - ##### 10:19:30 INFO - ##### 10:19:30 INFO - ##### Running install step. 10:19:30 INFO - ##### 10:19:30 INFO - Running pre-action listener: _resource_record_pre_action 10:19:30 INFO - Running main action method: install 10:19:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:30 INFO - Reading from file tmpfile_stdout 10:19:30 INFO - Detecting whether we're running mozinstall >=1.0... 10:19:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:19:30 INFO - Reading from file tmpfile_stdout 10:19:30 INFO - Output received: 10:19:30 INFO - Usage: mozinstall [options] installer 10:19:30 INFO - Options: 10:19:30 INFO - -h, --help show this help message and exit 10:19:30 INFO - -d DEST, --destination=DEST 10:19:30 INFO - Directory to install application into. [default: 10:19:30 INFO - "/builds/slave/test"] 10:19:30 INFO - --app=APP Application being installed. [default: firefox] 10:19:30 INFO - mkdir: /builds/slave/test/build/application 10:19:30 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'] 10:19:30 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 10:19:46 INFO - Reading from file tmpfile_stdout 10:19:46 INFO - Output received: 10:19:46 INFO - /builds/slave/test/build/application/firefox/firefox 10:19:46 INFO - Running post-action listener: _resource_record_post_action 10:19:46 INFO - ##### 10:19:46 INFO - ##### Finished install step (success) 10:19:46 INFO - ##### 10:19:46 INFO - ##### 10:19:46 INFO - ##### Running run-tests step. 10:19:46 INFO - ##### 10:19:46 INFO - Running pre-action listener: _resource_record_pre_action 10:19:46 INFO - Running main action method: run_tests 10:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:19:46 INFO - Python 2.7.3 10:19:46 INFO - Return code: 0 10:19:46 INFO - grabbing minidump binary from tooltool 10:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:46 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 0x1af92e0>, '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 0x1a65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a655d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:19:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:19:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:19:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:19:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:19:46 INFO - Return code: 0 10:19:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:19:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:19:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:19:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:19:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:19:47 INFO - Return code: 0 10:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 10:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 10:19:47 INFO - Using env: {'DISPLAY': ':0', 10:19:47 INFO - 'HOME': '/home/cltbld', 10:19:47 INFO - 'LANG': 'en_US.UTF-8', 10:19:47 INFO - 'LANGUAGE': 'en_US:en', 10:19:47 INFO - 'LOGNAME': 'cltbld', 10:19:47 INFO - 'MAIL': '/var/mail/cltbld', 10:19:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:19:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:47 INFO - 'MOZ_NO_REMOTE': '1', 10:19:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:47 INFO - 'NO_EM_RESTART': '1', 10:19:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:47 INFO - 'PWD': '/builds/slave/test', 10:19:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:19:47 INFO - 'SHELL': '/bin/bash', 10:19:47 INFO - 'SHLVL': '1', 10:19:47 INFO - 'TERM': 'linux', 10:19:47 INFO - 'TMOUT': '86400', 10:19:47 INFO - 'USER': 'cltbld', 10:19:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466528662.338014-2147016368', 10:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:47 INFO - '_': '/tools/buildbot/bin/python'} 10:19:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 10:19:47 INFO - mozversion application_buildid: 20160621090403 10:19:47 INFO - mozversion application_changeset: 7fb69043ac05ed4c505a4a14f9c1a3130aa1715d 10:19:47 INFO - mozversion application_display_name: Nightly 10:19:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:19:47 INFO - mozversion application_name: Firefox 10:19:47 INFO - mozversion application_remotingname: firefox 10:19:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:19:47 INFO - mozversion application_vendor: Mozilla 10:19:47 INFO - mozversion application_version: 50.0a1 10:19:47 INFO - mozversion platform_buildid: 20160621090403 10:19:47 INFO - mozversion platform_changeset: 7fb69043ac05ed4c505a4a14f9c1a3130aa1715d 10:19:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:19:47 INFO - mozversion platform_version: 50.0a1 10:19:47 INFO - using testdate: 1466529587 10:19:47 INFO - actual date: 1466529587 10:19:47 INFO - starting webserver on 'localhost:49237' 10:19:47 INFO - SUITE-START | Running 2 tests 10:19:47 INFO - TEST-START | dromaeo_css 10:19:47 INFO - operating with platform_type : linux_ 10:19:47 INFO - Initialising browser for dromaeo_css test... 10:19:47 INFO - TEST-INFO | started process 17010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg_hmyM/profile http://localhost:49237/getInfo.html) 10:19:52 INFO - PROCESS | 17010 | __metrics Screen width/height:1600/1200 10:19:52 INFO - PROCESS | 17010 | colorDepth:24 10:19:52 INFO - PROCESS | 17010 | Browser inner width/height: 1024/697 10:19:52 INFO - PROCESS | 17010 | __metrics 10:19:53 ERROR - PROCESS | 17010 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 10:19:54 INFO - TEST-INFO | 17010: exit 0 10:19:54 INFO - Browser initialized. 10:19:54 INFO - Running cycle 1/1 for dromaeo_css test... 10:19:54 INFO - TEST-INFO | started process 17128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg_hmyM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:06 INFO - PROCESS | 17128 | RSS: Main: 185901056 10:20:06 INFO - PROCESS | 17128 | 10:20:56 INFO - PROCESS | 17128 | 1466529656277 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:23:08 INFO - PROCESS | 17128 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 10:23:09 INFO - PROCESS | 17128 | RSS: Main: 189874176 10:23:09 INFO - PROCESS | 17128 | 10:26:11 INFO - PROCESS | 17128 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 10:26:12 INFO - PROCESS | 17128 | RSS: Main: 188649472 10:26:12 INFO - PROCESS | 17128 | 10:29:14 INFO - PROCESS | 17128 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 10:29:15 INFO - PROCESS | 17128 | RSS: Main: 189853696 10:29:15 INFO - PROCESS | 17128 | 10:32:16 INFO - PROCESS | 17128 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 10:32:17 INFO - PROCESS | 17128 | RSS: Main: 187469824 10:32:17 INFO - PROCESS | 17128 | 10:35:20 INFO - PROCESS | 17128 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 10:35:20 INFO - PROCESS | 17128 | RSS: Main: 189657088 10:35:20 INFO - PROCESS | 17128 | 10:38:23 INFO - PROCESS | 17128 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 10:38:23 INFO - PROCESS | 17128 | RSS: Main: 190857216 10:38:23 INFO - PROCESS | 17128 | 10:38:23 INFO - PROCESS | 17128 | __start_tp_report 10:38:23 INFO - PROCESS | 17128 | _x_x_mozilla_page_load 10:38:23 INFO - PROCESS | 17128 | _x_x_mozilla_page_load_details 10:38:23 INFO - PROCESS | 17128 | |i|pagename|runs| 10:38:23 INFO - PROCESS | 17128 | |0;dojo.html;2595;2625.579907214844;2646.5236257473657;2647.2720001999446;2661.414488812462;4577.267637178048;4614.3539904413365;4626.514216007321;4722.150012997659;4747.28790681398;4633.49031606523;4659;4666.953330466695;4697.6241900647865;4725.291206319045;4252.723572967755;4338.479382474107;4377.715448495837;4398.516163222059;4398.736075835444;557.3908532721388;4239.2793225151645;4351.129774045188;4355.259605866994;4401.031773009932;4273.038566322568;4310.43964284641;4320.071184695305;4340.240457919851;4348.869533913956;4241.724287921306;4297.312430011183;4317.395564620955;4318.3090705486975;4363.454568178978;4257.510386305584;4304.053108316165;4321.0709697414895;4322.848700295506;4329.19909816685;4722.76386180693;4756.97724989129;4788.401449818773;4792.305115758196;4810.237864514106;5122.462141475166;5167.715775632339;5181.300524429192;5187.299714538527;5241.266222728821;5225.947740522623;5226.111561034595;5228.215767634847;5228.764705588258;5268.078086334915;4837.298591704183;4873.658843880929;4878.829240976549;4883.365162528919;4888.095702295087;5247.842564723064;5264.763085661154;5307.65500242483;5319.521243088141;5333.466653334635;5103.693778373309;5114.539691427789;5117.360329958755;5131.640785145004;5169.586433085344;4978.402591688948;5210.322658054429;5212.791488340424;5214.556762675139;5220.973895130576;5023.8492845214705;5036.294918711384;5079.548683994031;5079.644424890223;5107.412647545506;4864.951350486521;4970.229614409773;4989.301497790312;5038.345015148007;5044;4109.4246805447265;4210.5157906840495;4219.620234178878;4232.555581663881;4277.123189746095;3704.2776658551325;3718.7768733876055;3729.4965179700935;3772.39641657339;3809.3143234218105;4453.087117140978;4490;4494.258447356149;4494.303382975644;4532.660050496226;5032.72320022395;5097.46476619957;5123.538881500608;5152.252923326097;5181.533661970366;4436.511983681792;4449.7775111244955;4450.933236001462;4479.7536135512855;4492.932606010912;4484.1031793641405;4528.88677783058;4535.297028960516;4537.251353526697;4589.472210695746;4793.28100784892;4796.5203479651755;4810.5670489656095;4815.374001379798;4824.589909857701;5102.387713474407;5140.049090918043;5142.1772516397195;5147.2536482209125;5154.819581314786;4678.368420263221;4816.229403295456;4863.221884498464;4874.463808980939;4904.2643603459765;5005.274235235943;5023.120953833138;5063;5079.898402032012;5081;5133.922991155061;5163.328767260232;5169.53474187325;5172.069027574922;5174.390207434179;4864.367632207932;4882.731449770296;4984.22744474607;5013.348264725562;5015.623828212826;4860.416749990024;4863.95136048635;4878.317035615088;4936.9259461107395;4974.502549744997;4849.75751212445;4866.48901865299;4875.658703890694;4927.704337739604;4936.234883593049;4892.119418504561;4945.357103576512;5027.32131162303;5035.773390197523;5093.617978651542;4890.144224760582;4910.8281210157475;4916.803327866845;4929.457759646364;4976.452590215001 10:38:23 INFO - PROCESS | 17128 | |1;ext.html;541.136886665768;581.482480592273;594.5184400635486;611.8653896142847;614.1647359590955;35019.47470787937;38675.22649547011;38708.225835483274;38797.80601096997;38876.80561597191;39052;39505.209895802065;39715.20569588606;39751.40372894409;39971.40042899359;7645.961770191155;7851.45039847211;7857.1357150713375;7858.253465920729;7863.252990965849;7558.886616700754;7564.281393267631;7575;7581.810454738648;7623.047119110111;7596;7606.087269527665;7650.426218033642;7653.425993050543;7675.424343174256;7612.162662107219;7627.237276272356;7650.464467487306;7652.617369131549;7652.69389224436;7838.76483705484;7859.331956783681;7912.841743165162;7920.009998750156;7921.128675845653;29657.40685186306;37722;37854.62145378539;37917.62082379169;38112.80943595292;2875.07997440819;2905.680375158731;2967.4806908790874;3115.1589070950945;3391.8134502602347;28057.579136312972;30038.098857034325;30486.085417437513;30545.541816872767;30555.23611909698;3485.1112966193714;3570.3751843427294;3587.7667951583326;3593.3531964246426;3597.460380942853;265585;268177.999999998;268675;269477;270608;55448.168277475874;57090;57162.42837571654;57198;57223.71388143116;51570.484295157316;58351.41648583545;59937;60202;60605.39394606086;12934;12994.155379900276;13018.89339406142;13036.54372096991;13121.409536570687;9929.553170107363;9969.55137018836;9984.700458986243;10026.548805303779;10042.49787510636;18309.176087076114;18446.81553184451;18452.26190952374;18552.44342669722;18680;6855.760048398282;6934.341237582422;6995.650217489105;7038.718451261994;7143.39273663432;781.2421950707804;876.1895246896722;900.5497251374313;948.62055177928;971.3831716859704;27152;28405.147845564665;28545.714542854304;28678;28844.567331490045;903.1961554216753;926.8424367857481;934.9953250233841;980.313780353741;1026.030401270792;13759.17444953306;14114.576562703136;14284;14460.20468874222;14495.492657757139;405990;412924;413776;414291;417744;47834.76082619565;48294.758526207144;48393.516064839605;48483;48658.75670621695;1147.3230793831679;1178.3283528388909;1178.5757127434117;1179.097990037622;1207.8610959739567;25464.236072917844;26666.200013999613;26761.197164085108;27202.31994200161;27219.59170612403;40340.79829600833;40443;41239.587604123575;41349.586504134575;41383.793081034404;373981;374768;374911;375408;375492;24790.752092479564;25250.116245931305;25265.368365791;25279;25297.87351063233;39972.40041399323;39997;40200.39699404453;40842;41127.38308925428;33795.493067603515;34308.48537271993;34725;35068.14250432501;35502.28995420129;34206.486902696975;34609.48085778665;34692.30615387628;34824;35265.47101793424;29457.410851783272;34285;34329.48505772366;34501.827490862386;34687.653123468444;29164.70835291705;31341.52987705232;31507.52738708967;31556.36887262288;31900.840495797373;25029.249122526355;25231.864566094202;25406.618900716872;25413.74586254114;25686 10:38:23 INFO - PROCESS | 17128 | |2;jquery.html;370.61826318891553;372.84340576957675;373.9308227977824;377.09309111586634;389.9961000389997;15477.845221547781;15891;17023.489295321127;17044.14779261035;17052.23264953077;15598.922005389957;15683.529494115166;16802.66394672106;16866.156692165372;16892.493225203263;5152;5267.683938963674;5316.12283973144;5323.893522129574;5357.464253574631;4838.346823178878;5237.869053273661;5288.6562373445795;5298.23175639532;5311.73441327934;5108.1060814357525;5233.842984710445;5236.2931004314505;5237.266782650432;5241.711705856176;5086.237064440345;5155.948440515603;5158.7420628968775;5164.302819119408;5176.249443830642;5170.379554453452;5261.97391508656;5264.184051472028;5298.125809241471;5299.099153143975;17604.471865844047;18648.160832762558;18696.81303186978;19118;20502.38492845217;1717.4332470284776;1746.8253174682557;1850.824171703686;1865.2632210277;1878.4176905159309;8047.637856296422;8510.574471276474;8733.650653973833;9892.802143957153;13663.658408539766;1526.450477827981;1609.6378314879175;1759.2347328911965;1762.8060913299528;1769.3630293094475;60730;61753.382466175215;63249.36750632481;63345.29892309714;63656.999999999534;8173.346132309401;8761.474311541328;8903.599338029804;8911.019787823334;9081.409708369067;11492.310461372344;11496.137789665809;11559.266110083554;11577;11616.535338586362;6560.770373036921;6632.668366581748;6774.898376524356;6813.591184528944;6823.283555226729;6339.144215530937;6409.359064093554;6511.706973186123;6653.534252602271;6664.700088496029;3626.6192049834917;3664.4686520454916;3728.440733889884;3799.0502374406396;3870.825812838429;1668.3410053028986;1679.2443400469838;1756.5432987423108;1769.8672599555084;1778.084286592406;805.2350267246139;835.0814104485017;856.0369584217755;875.2166810704384;909.340727972228;17014.234359453854;17282.481525554;17449.12754362277;17486.21312040961;17759.822401776077;832.1678321678322;842.1304703558092;863.887694599698;865.6191275838611;868.444195714743;9434.3867648604;9608.807823843485;9639.18066964302;9658.179054780281;9754.904895914438;366312;383000;383797;385969;386203;57822;69367.30632693609;69431.65284173648;71851.64074179596;72768;886.2334081019872;906.1799071839995;922.7693076730683;932.1470854168496;935.7286386947709;15526.9223653881;15621.843781562493;15807;16150.515484535483;16237.269322880262;34830.47754283738;35711.82144089263;36087.819560902026;36411.45382819313;36633.816830915675;46156;50542;51363.743181283855;51418;51715;7484.700611975678;7583.469157158946;7657.851322301476;7675.232476752503;7710.92289077102;10562.683119506428;11764.235324703866;11863.525458981889;11994.160408771651;12022.699432513908;8966.327525435488;9007;9234.1689247968;9629.759256018375;9782.853257201004;8757.343199260209;10174.287799853939;10232;10291.53688084023;10411.84382234252;8997.515409957283;9130.817383652156;10050.19598432109;10282.897171028193;10324.690259292232;7504.212057733859;7525.849483010418;7705.113911900204;7707.421943354383;7807.726729564438;7453.2546745325035;9503.239740820856;9894.307398482037;10018.499075046364;10122 10:38:23 INFO - PROCESS | 17128 | |3;mootools.html;1356.7083077138416;1408.4999825062102;1446.6094154578263;1613.3949768836694;1619.2875134940632;6808.080909077273;7440.702371905118;7531.774046778592;8176.305014073796;8188.549629770368;7537.09554853417;7790.571518566477;7853.37173026158;7855.13593504714;7891.960540197305;2181.879996600186;2225.4547635829244;2226.8329875259337;2229.8104661103744;2241.4508445430893;2145.5279838435517;2190.321000489845;2210.071769856664;2210.557888422314;2215.0475295622878;2153.655415133579;2170.598439288729;2171.761106278308;2173.869567825928;2185.89070546472;2124.2989813361633;2134.7758485359122;2136.465883529118;2136.583366243583;2144.453164443057;2131.7441906971108;2179.978200218009;2181.4873504726374;2198.219632030622;2203.4271089516683;7730.690772369098;7829.530228186327;7849.882251766228;7859.52842829432;7860.449768516206;4544.636429085665;4585.7248565085865;4604.815807367735;4613.331066995301;4637.026224492861;2788.9721102788917;2873.913782586526;2964;2979.970200297991;2983.9403211935855;900.7252787899688;904.6155383961856;944.0795224655974;944.8063147054906;950.021477877787;10531.210159238011;10559.630412935587;10644.733881652943;10748.355098694024;10751.569937202503;4115.71190016702;4181.435506206684;4265.168292183057;4279.786010699452;4298.2263192625005;9153.679621213225;9176.95411522938;9189.770255743526;9271.07289271081;9288.303377246733;4730.692504987165;4742.73914934675;4745.3593764842;4745.525447455296;4745.83389581363;3695;4148.522919864255;4231.894202644959;4289.420928174656;4319.136172765459;3578.4095624221713;3631;3715.0898029982286;3749.7937613431523;3823.923521529554;1184.549871049013;1209.4194786502528;1213.5995121610024;1217.4947396830216;1219.6584956212275;687.4225650453643;819.3568049081442;819.9139090395541;845.9577021149041;847.5931552854664;5095.439501654815;5305.336832895888;5348.679079255257;5351.678899266057;5370.087085195526;399.7062159312903;405.78087832570674;409.08977525007214;414.1654566049413;414.2770864840872;3626.637336266352;3669.174435751988;3703.814809259526;3735.34631439497;3750.6999440044733;9404.90595094054;9693.660721874841;9731.756706082404;9826.852597211047;9874.950625246971;9648.614055437843;9701.223902087817;9702.466364349888;9710.320277580502;9740.853887191697;7001.614911179934;7216.639168041577;7243.60160191184;7322.487425880244;7331.450141239428;5072.239164125411;5092.949070509248;5106.565941894981;5230.398504172069;5272.499112584298;8791.648334066565;8878;8996.775080623036;9104.044075372256;9125.722398864296;8930.642774289216;9270.675526356816;9271.6291348348;9302.488363140092;9322.720318390458;6021.819345419644;6559.278479367361;6772.898406524005;6795.626240556817;6918.273581273894;7422.443316751157;7497.812554686177;7515.286047825448;7559.470837041575;7562.810929726801;6580.7038683260325;6615.338466153538;6621.966890165519;6745.392914637706;6886.070380498769;6874.862502749817;6891.689873955584;6898.758543450955;6950.374466298057;6972.6862291196;6035.426634469718;6063.575549711654;6065.332813390612;6084.787032453843;6105.664188469676;4512.278035514302;4564.383808185985;4660.510646382217;4683.461401938821;4687.578117969263;4424.535423780457;4454.175977444053;4514.796834142538;4695.812167513262;4779.856604301876 10:38:23 INFO - PROCESS | 17128 | |4;prototype.html;292.8608910767386;302.455579956079;307.7937781686273;310.19040304804463;316.94453470642634;4748.738819364942;4749.319277559893;4895.877603059926;4963.726995015273;5003.399592048954;4839.733814640203;4863.586595139409;4889.877753056176;4891.8777030574165;4937.679050861691;3862.4206369044587;3866.439366291886;3882.9223415531674;3883.2233553289316;3891.824867880938;3793.525809273841;3886.553046399672;3886.8639597614088;3916;3916.941245881314;3778.886633401002;3855.7108216883707;3874.9806250968704;3877.2827026999953;3881.4177873319086;3814.9618503814886;3815.1606646537857;3823.9808800955816;3834.5973672764517;3871.8838434847;3420.572428446444;3444.328355970587;3447.1382154461385;3448.7241020718284;3455.4298540740747;4737.549932756383;4827.782749776268;4840.806367745286;4891.168501354743;4915.631327650441;4444.644428445717;4452.46389995451;4461.992103553382;4476.664250181217;4489.124620698965;5192.169252919514;5219.060569097561;5237.816676416307;5244.842654720364;5247.632665713401;3717.2937141943216;3783.6027217142077;3813.7139714521522;3820.465134881119;3832.329342365075;5418.485243901862;5459.153831156177;5466.699331536764;5478.260434841285;5483.917741233885;3844.3272427325105;3865.8067096645054;3872.9806350968065;3874.4188371744463;3883.223355328889;3933.4099885016903;3937.350337194388;3942.1918506706056;3942.586028467027;3952.7233093683167;4287.370799096323;4398.846040388571;4426.336049592587;4427.180971520279;4436.8447104351835;5157.252198431206;5193.324867767166;5208.817691380859;5224.895502089937;5226.529612334908;1278.7314663920681;1329.4947919790418;1361.6187467509114;1365.8458602480887;1367.8426980897125;880.335346813152;882.4131952251809;896.2561074308309;908.52756566585;911.2163539356148;4094.8566800161852;4107.843382224356;4112;4117.485314335708;4164.958350416457;4710.364100846342;4755.5482229188865;4756.075013866516;4779.689320194177;4794.616430685537;4071.42999980003;4118.19695159441;4126.5667104953545;4130.938035929404;4157.417961485395;2571.768540831297;2669.8131130820657;2905.898293559715;2911.8252904825777;2915.489789286909;5097.847064588068;5137.280780690707;5144.279800827887;5146.588272938156;5196.53231209193;5292.20616907467;5506.862328441821;5597.776088956396;5599.944000559943;5617;5072.376839411427;5089.167899556157;5100.770465329069;5107.79568817258;5117.822900732778;5342.332208473941;5426.647267927572;5437.483439073281;5442.782288708566;5458;5040.773165207501;5300.2049692546425;5305.575553955597;5324.988252232063;5350.652207606493;5053.772580233825;5080.390353157644;5086.847394578021;5110.441315398691;5143.691378517301;3812.8856134316015;3831.63599458051;3833.6933045356864;3834.8657796978086;3878.204967981613;5211.5049070338255;5280.234366016983;5426.267453893832;5435.429279925551;5452.618316717951;5225.137852254487;5249.160134378481;5264.657797243167;5272.393674727456;5294.682319060868;5269.736513174403;5270.8155214567305;5276.736163191902;5280.102382595045;5308.362996440452;4908.877278067934;5165.509276618715;5168.8449346519665;5202.3497062867145;5209.348831396075;5256.579473642023;5263;5265.60507961912;5288.206768984529;5295.920561191662;5147.58819294448;5164.340364712101;5165.92251116226;5177;5179.896402072013 10:38:23 INFO - PROCESS | 17128 | |5;yui.html;687.88305987982;716.2550947015104;727.4689476682022;747.1333253426027;771.6836097200149;12611.18027328223;13239;13324.733505329912;13365.7326853463;13456.596302110927;12917.870821291785;13156.868431315685;13391.263480508567;13406.262655553941;13454.663633409169;783.6356094416095;785.3873978296938;787.9606019699021;788.5071830106184;789.34090034821;777.4014009212902;781.6443518199205;782.0341877780965;782.3350152370468;783.4946459533597;805.6414895371562;811.0227176252631;811.1888111888112;812.6627449608405;812.6830536090929;796.0288448093346;800.2597597222546;802.5345299726145;806.0931452116369;807.1887752808449;583.1456915618639;588.3675049321953;589.0016422164433;590.5246276747217;590.6898878088995;12159.756804863942;12262.38688065602;12267.69330766729;12378.257304561665;12383.690407739788;10955.233133680646;11006;11038.889611103867;11147.275427097295;11406.31562106268;9491.098345657152;9514.714558563253;9588.856167157499;9658.855117173249;9762.56068476913;3259.429599820022;3318.8451255395516;3341.7827841190247;3345.9498107528407;3377.8817741378934;41111.1777764443;52689.2096618551;52933.735331323485;57933;59808.70095649538;10621.1352465515;10666.200034997406;10711.73220669474;10792.622258220925;10926.289791163548;19574.412767616996;19582.118804653826;19584.21663133487;19606.509837254183;19691.212351506067;7116.64416779159;7130.714771409085;7212.855742885218;7259.2377800330205;7303.780886573411;3662.8278950735507;3745.8127093645753;3787.715921305858;3833.884983450501;3838.808059597009;2943.67619561848;3031.6362036555756;3052.069118918751;3053.6793636668276;3057.969420305813;517.1286382445516;521.6322492642678;533.3280067115462;539.3096836049863;539.5144370066971;474.68511232893167;551.4292707048186;571.1632458448393;578.7135367992786;586.8327526654969;7410.962945185347;7609.467337286337;7630.160682324939;7697.384209263358;8184.836303273901;429.02611072864426;553.720371212535;563.5207580102232;567.336216626548;567.6764244380663;3519.260955199437;3642.85428582859;3705.4997575326984;3786.091338078841;3864.9806750966627;95900.52049739847;96673;97036;99398;99956.50021749844;56243;69593.3040669597;82733;82960.58519707483;84073;72983.63508182531;75711.62144189244;75835.62082189554;75867;78058.89465111945;8399.790005249673;8672.653093876173;8751.737447876574;8761.518116503654;8789.912100879164;42013.78993105015;42201.78899105485;42226.155476889675;42328.57671423246;42740;61681;63161;63169;63464.36535634584;63834.3616563847;11479.196456247982;11649.136138217844;11672.182947193614;11710.70723231926;12092;12782.61652150437;12973.22160670325;12988.701129886937;13677.726445470837;13753.724925501234;11383.601573944872;11716.121290903387;11994.520219191134;12243.75512489763;12293.815592766294;11563.248388854698;11579.652610421701;11642.126840486828;11901.10741694359;12171.573994910135;11553.537858485903;11574.421278936188;11886.940565297118;12143.696407589881;12397.256164630151;10374.619643836922;10500.422476763852;10735.516901739597;10836.566537338733;10911.836322455329;9597.184239339735;9805.607775688892;9845.704628861145;9867.506624668882;9879.703608891745 10:38:23 INFO - PROCESS | 17128 | __end_tp_report 10:38:23 INFO - PROCESS | 17128 | __start_cc_report 10:38:23 INFO - PROCESS | 17128 | _x_x_mozilla_cycle_collect,412 10:38:23 INFO - PROCESS | 17128 | __end_cc_report 10:38:23 INFO - PROCESS | 17128 | __startTimestamp1466530703768__endTimestamp 10:38:23 INFO - PROCESS | 17128 | 10:38:23 INFO - PROCESS | 17128 | ------- Summary: start ------- 10:38:23 INFO - PROCESS | 17128 | Number of tests: 6 10:38:23 INFO - PROCESS | 17128 | 10:38:23 INFO - PROCESS | 17128 | [#0] dojo.html Cycles:165 Average:4689.51 Median:4864.95 stddev:611.00 (12.6%) stddev-sans-first:590.37 10:38:23 INFO - PROCESS | 17128 | Values: 2595.0 2625.6 2646.5 2647.3 2661.4 4577.3 4614.4 4626.5 4722.2 4747.3 4633.5 4659.0 4667.0 4697.6 4725.3 4252.7 4338.5 4377.7 4398.5 4398.7 557.4 4239.3 4351.1 4355.3 4401.0 4273.0 4310.4 4320.1 4340.2 4348.9 4241.7 4297.3 4317.4 4318.3 4363.5 4257.5 4304.1 4321.1 4322.8 4329.2 4722.8 4757.0 4788.4 4792.3 4810.2 5122.5 5167.7 5181.3 5187.3 5241.3 5225.9 5226.1 5228.2 5228.8 5268.1 4837.3 4873.7 4878.8 4883.4 4888.1 5247.8 5264.8 5307.7 5319.5 5333.5 5103.7 5114.5 5117.4 5131.6 5169.6 4978.4 5210.3 5212.8 5214.6 5221.0 5023.8 5036.3 5079.5 5079.6 5107.4 4865.0 4970.2 4989.3 5038.3 5044.0 4109.4 4210.5 4219.6 4232.6 4277.1 3704.3 3718.8 3729.5 3772.4 3809.3 4453.1 4490.0 4494.3 4494.3 4532.7 5032.7 5097.5 5123.5 5152.3 5181.5 4436.5 4449.8 4450.9 4479.8 4492.9 4484.1 4528.9 4535.3 4537.3 4589.5 4793.3 4796.5 4810.6 4815.4 4824.6 5102.4 5140.0 5142.2 5147.3 5154.8 4678.4 4816.2 4863.2 4874.5 4904.3 5005.3 5023.1 5063.0 5079.9 5081.0 5133.9 5163.3 5169.5 5172.1 5174.4 4864.4 4882.7 4984.2 5013.3 5015.6 4860.4 4864.0 4878.3 4936.9 4974.5 4849.8 4866.5 4875.7 4927.7 4936.2 4892.1 4945.4 5027.3 5035.8 5093.6 4890.1 4910.8 4916.8 4929.5 4976.5 10:38:23 INFO - PROCESS | 17128 | 10:38:23 INFO - PROCESS | 17128 | [#1] ext.html Cycles:180 Average:49883.65 Median:37788.31 stddev:94484.11 (250.0%) stddev-sans-first:94676.53 10:38:23 INFO - PROCESS | 17128 | Values: 541.1 581.5 594.5 611.9 614.2 35019.5 38675.2 38708.2 38797.8 38876.8 39052.0 39505.2 39715.2 39751.4 39971.4 7646.0 7851.5 7857.1 7858.3 7863.3 7558.9 7564.3 7575.0 7581.8 7623.0 7596.0 7606.1 7650.4 7653.4 7675.4 7612.2 7627.2 7650.5 7652.6 7652.7 7838.8 7859.3 7912.8 7920.0 7921.1 29657.4 37722.0 37854.6 37917.6 38112.8 2875.1 2905.7 2967.5 3115.2 3391.8 28057.6 30038.1 30486.1 30545.5 30555.2 3485.1 3570.4 3587.8 3593.4 3597.5 265585.0 268178.0 268675.0 269477.0 270608.0 55448.2 57090.0 57162.4 57198.0 57223.7 51570.5 58351.4 59937.0 60202.0 60605.4 12934.0 12994.2 13018.9 13036.5 13121.4 9929.6 9969.6 9984.7 10026.5 10042.5 18309.2 18446.8 18452.3 18552.4 18680.0 6855.8 6934.3 6995.7 7038.7 7143.4 781.2 876.2 900.5 948.6 971.4 27152.0 28405.1 28545.7 28678.0 28844.6 903.2 926.8 935.0 980.3 1026.0 13759.2 14114.6 14284.0 14460.2 14495.5 405990.0 412924.0 413776.0 414291.0 417744.0 47834.8 48294.8 48393.5 48483.0 48658.8 1147.3 1178.3 1178.6 1179.1 1207.9 25464.2 26666.2 26761.2 27202.3 27219.6 40340.8 40443.0 41239.6 41349.6 41383.8 373981.0 374768.0 374911.0 375408.0 375492.0 24790.8 25250.1 25265.4 25279.0 25297.9 39972.4 39997.0 40200.4 40842.0 41127.4 33795.5 34308.5 34725.0 35068.1 35502.3 34206.5 34609.5 34692.3 34824.0 35265.5 29457.4 34285.0 34329.5 34501.8 34687.7 29164.7 31341.5 31507.5 31556.4 31900.8 25029.2 25231.9 25406.6 25413.7 25686.0 10:38:23 INFO - PROCESS | 17128 | 10:38:23 INFO - PROCESS | 17128 | [#2] jquery.html Cycles:180 Average:23317.95 Median:5167.34 stddev:62721.34 (1213.8%) stddev-sans-first:62873.63 10:38:23 INFO - PROCESS | 17128 | Values: 370.6 372.8 373.9 377.1 390.0 15477.8 15891.0 17023.5 17044.1 17052.2 15598.9 15683.5 16802.7 16866.2 16892.5 5152.0 5267.7 5316.1 5323.9 5357.5 4838.3 5237.9 5288.7 5298.2 5311.7 5108.1 5233.8 5236.3 5237.3 5241.7 5086.2 5155.9 5158.7 5164.3 5176.2 5170.4 5262.0 5264.2 5298.1 5299.1 17604.5 18648.2 18696.8 19118.0 20502.4 1717.4 1746.8 1850.8 1865.3 1878.4 8047.6 8510.6 8733.7 9892.8 13663.7 1526.5 1609.6 1759.2 1762.8 1769.4 60730.0 61753.4 63249.4 63345.3 63657.0 8173.3 8761.5 8903.6 8911.0 9081.4 11492.3 11496.1 11559.3 11577.0 11616.5 6560.8 6632.7 6774.9 6813.6 6823.3 6339.1 6409.4 6511.7 6653.5 6664.7 3626.6 3664.5 3728.4 3799.1 3870.8 1668.3 1679.2 1756.5 1769.9 1778.1 805.2 835.1 856.0 875.2 909.3 17014.2 17282.5 17449.1 17486.2 17759.8 832.2 842.1 863.9 865.6 868.4 9434.4 9608.8 9639.2 9658.2 9754.9 366312.0 383000.0 383797.0 385969.0 386203.0 57822.0 69367.3 69431.7 71851.6 72768.0 886.2 906.2 922.8 932.1 935.7 15526.9 15621.8 15807.0 16150.5 16237.3 34830.5 35711.8 36087.8 36411.5 36633.8 46156.0 50542.0 51363.7 51418.0 51715.0 7484.7 7583.5 7657.9 7675.2 7710.9 10562.7 11764.2 11863.5 11994.2 12022.7 8966.3 9007.0 9234.2 9629.8 9782.9 8757.3 10174.3 10232.0 10291.5 10411.8 8997.5 9130.8 10050.2 10282.9 10324.7 7504.2 7525.8 7705.1 7707.4 7807.7 7453.3 9503.2 9894.3 10018.5 10122.0 10:38:23 INFO - PROCESS | 17128 | 10:38:23 INFO - PROCESS | 17128 | [#3] mootools.html Cycles:180 Average:5142.79 Median:5082.59 stddev:2909.65 (57.2%) stddev-sans-first:2903.91 10:38:23 INFO - PROCESS | 17128 | Values: 1356.7 1408.5 1446.6 1613.4 1619.3 6808.1 7440.7 7531.8 8176.3 8188.5 7537.1 7790.6 7853.4 7855.1 7892.0 2181.9 2225.5 2226.8 2229.8 2241.5 2145.5 2190.3 2210.1 2210.6 2215.0 2153.7 2170.6 2171.8 2173.9 2185.9 2124.3 2134.8 2136.5 2136.6 2144.5 2131.7 2180.0 2181.5 2198.2 2203.4 7730.7 7829.5 7849.9 7859.5 7860.4 4544.6 4585.7 4604.8 4613.3 4637.0 2789.0 2873.9 2964.0 2980.0 2983.9 900.7 904.6 944.1 944.8 950.0 10531.2 10559.6 10644.7 10748.4 10751.6 4115.7 4181.4 4265.2 4279.8 4298.2 9153.7 9177.0 9189.8 9271.1 9288.3 4730.7 4742.7 4745.4 4745.5 4745.8 3695.0 4148.5 4231.9 4289.4 4319.1 3578.4 3631.0 3715.1 3749.8 3823.9 1184.5 1209.4 1213.6 1217.5 1219.7 687.4 819.4 819.9 846.0 847.6 5095.4 5305.3 5348.7 5351.7 5370.1 399.7 405.8 409.1 414.2 414.3 3626.6 3669.2 3703.8 3735.3 3750.7 9404.9 9693.7 9731.8 9826.9 9875.0 9648.6 9701.2 9702.5 9710.3 9740.9 7001.6 7216.6 7243.6 7322.5 7331.5 5072.2 5092.9 5106.6 5230.4 5272.5 8791.6 8878.0 8996.8 9104.0 9125.7 8930.6 9270.7 9271.6 9302.5 9322.7 6021.8 6559.3 6772.9 6795.6 6918.3 7422.4 7497.8 7515.3 7559.5 7562.8 6580.7 6615.3 6622.0 6745.4 6886.1 6874.9 6891.7 6898.8 6950.4 6972.7 6035.4 6063.6 6065.3 6084.8 6105.7 4512.3 4564.4 4660.5 4683.5 4687.6 4424.5 4454.2 4514.8 4695.8 4779.9 10:38:23 INFO - PROCESS | 17128 | 10:38:23 INFO - PROCESS | 17128 | [#4] prototype.html Cycles:180 Average:4306.60 Median:4852.20 stddev:1254.35 (25.9%) stddev-sans-first:1221.16 10:38:23 INFO - PROCESS | 17128 | Values: 292.9 302.5 307.8 310.2 316.9 4748.7 4749.3 4895.9 4963.7 5003.4 4839.7 4863.6 4889.9 4891.9 4937.7 3862.4 3866.4 3882.9 3883.2 3891.8 3793.5 3886.6 3886.9 3916.0 3916.9 3778.9 3855.7 3875.0 3877.3 3881.4 3815.0 3815.2 3824.0 3834.6 3871.9 3420.6 3444.3 3447.1 3448.7 3455.4 4737.5 4827.8 4840.8 4891.2 4915.6 4444.6 4452.5 4462.0 4476.7 4489.1 5192.2 5219.1 5237.8 5244.8 5247.6 3717.3 3783.6 3813.7 3820.5 3832.3 5418.5 5459.2 5466.7 5478.3 5483.9 3844.3 3865.8 3873.0 3874.4 3883.2 3933.4 3937.4 3942.2 3942.6 3952.7 4287.4 4398.8 4426.3 4427.2 4436.8 5157.3 5193.3 5208.8 5224.9 5226.5 1278.7 1329.5 1361.6 1365.8 1367.8 880.3 882.4 896.3 908.5 911.2 4094.9 4107.8 4112.0 4117.5 4165.0 4710.4 4755.5 4756.1 4779.7 4794.6 4071.4 4118.2 4126.6 4130.9 4157.4 2571.8 2669.8 2905.9 2911.8 2915.5 5097.8 5137.3 5144.3 5146.6 5196.5 5292.2 5506.9 5597.8 5599.9 5617.0 5072.4 5089.2 5100.8 5107.8 5117.8 5342.3 5426.6 5437.5 5442.8 5458.0 5040.8 5300.2 5305.6 5325.0 5350.7 5053.8 5080.4 5086.8 5110.4 5143.7 3812.9 3831.6 3833.7 3834.9 3878.2 5211.5 5280.2 5426.3 5435.4 5452.6 5225.1 5249.2 5264.7 5272.4 5294.7 5269.7 5270.8 5276.7 5280.1 5308.4 4908.9 5165.5 5168.8 5202.3 5209.3 5256.6 5263.0 5265.6 5288.2 5295.9 5147.6 5164.3 5165.9 5177.0 5179.9 10:38:23 INFO - PROCESS | 17128 | 10:38:23 INFO - PROCESS | 17128 | [#5] yui.html Cycles:180 Average:17257.21 Median:52811.47 stddev:24418.34 (46.2%) stddev-sans-first:24455.15 10:38:23 INFO - PROCESS | 17128 | Values: 687.9 716.3 727.5 747.1 771.7 12611.2 13239.0 13324.7 13365.7 13456.6 12917.9 13156.9 13391.3 13406.3 13454.7 783.6 785.4 788.0 788.5 789.3 777.4 781.6 782.0 782.3 783.5 805.6 811.0 811.2 812.7 812.7 796.0 800.3 802.5 806.1 807.2 583.1 588.4 589.0 590.5 590.7 12159.8 12262.4 12267.7 12378.3 12383.7 10955.2 11006.0 11038.9 11147.3 11406.3 9491.1 9514.7 9588.9 9658.9 9762.6 3259.4 3318.8 3341.8 3345.9 3377.9 41111.2 52689.2 52933.7 57933.0 59808.7 10621.1 10666.2 10711.7 10792.6 10926.3 19574.4 19582.1 19584.2 19606.5 19691.2 7116.6 7130.7 7212.9 7259.2 7303.8 3662.8 3745.8 3787.7 3833.9 3838.8 2943.7 3031.6 3052.1 3053.7 3058.0 517.1 521.6 533.3 539.3 539.5 474.7 551.4 571.2 578.7 586.8 7411.0 7609.5 7630.2 7697.4 8184.8 429.0 553.7 563.5 567.3 567.7 3519.3 3642.9 3705.5 3786.1 3865.0 95900.5 96673.0 97036.0 99398.0 99956.5 56243.0 69593.3 82733.0 82960.6 84073.0 72983.6 75711.6 75835.6 75867.0 78058.9 8399.8 8672.7 8751.7 8761.5 8789.9 42013.8 42201.8 42226.2 42328.6 42740.0 61681.0 63161.0 63169.0 63464.4 63834.4 11479.2 11649.1 11672.2 11710.7 12092.0 12782.6 12973.2 12988.7 13677.7 13753.7 11383.6 11716.1 11994.5 12243.8 12293.8 11563.2 11579.7 11642.1 11901.1 12171.6 11553.5 11574.4 11886.9 12143.7 12397.3 10374.6 10500.4 10735.5 10836.6 10911.8 9597.2 9805.6 9845.7 9867.5 9879.7 10:38:23 INFO - PROCESS | 17128 | -------- Summary: end -------- 10:38:23 INFO - PROCESS | 17128 | 10:38:24 INFO - TEST-INFO | 17128: exit 0 10:38:24 INFO - TEST-OK | dromaeo_css | took 1116880ms 10:38:24 INFO - TEST-START | kraken 10:38:24 INFO - operating with platform_type : linux_ 10:38:24 INFO - Initialising browser for kraken test... 10:38:24 INFO - TEST-INFO | started process 17361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz6lXJx/profile http://localhost:49237/getInfo.html) 10:38:29 INFO - PROCESS | 17361 | __metrics Screen width/height:1600/1200 10:38:29 INFO - PROCESS | 17361 | colorDepth:24 10:38:29 INFO - PROCESS | 17361 | Browser inner width/height: 1024/697 10:38:29 INFO - PROCESS | 17361 | __metrics 10:38:30 ERROR - PROCESS | 17361 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 10:38:31 INFO - TEST-INFO | 17361: exit 0 10:38:31 INFO - Browser initialized. 10:38:31 INFO - Running cycle 1/1 for kraken test... 10:38:31 INFO - TEST-INFO | started process 17477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz6lXJx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:43 INFO - PROCESS | 17477 | RSS: Main: 186880000 10:38:43 INFO - PROCESS | 17477 | 10:38:46 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:47 INFO - PROCESS | 17477 | RSS: Main: 191623168 10:38:47 INFO - PROCESS | 17477 | 10:38:50 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 10:38:50 INFO - PROCESS | 17477 | RSS: Main: 190775296 10:38:50 INFO - PROCESS | 17477 | 10:38:53 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 10:38:54 INFO - PROCESS | 17477 | RSS: Main: 187559936 10:38:54 INFO - PROCESS | 17477 | 10:38:56 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 10:38:57 INFO - PROCESS | 17477 | RSS: Main: 187383808 10:38:57 INFO - PROCESS | 17477 | 10:38:59 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:00 INFO - PROCESS | 17477 | RSS: Main: 187809792 10:39:00 INFO - PROCESS | 17477 | 10:39:03 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:03 INFO - PROCESS | 17477 | RSS: Main: 188014592 10:39:03 INFO - PROCESS | 17477 | 10:39:07 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:08 INFO - PROCESS | 17477 | RSS: Main: 185098240 10:39:08 INFO - PROCESS | 17477 | 10:39:11 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 10:39:11 INFO - PROCESS | 17477 | RSS: Main: 186843136 10:39:11 INFO - PROCESS | 17477 | 10:39:13 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:13 INFO - PROCESS | 17477 | RSS: Main: 186990592 10:39:13 INFO - PROCESS | 17477 | 10:39:15 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:16 INFO - PROCESS | 17477 | RSS: Main: 187301888 10:39:16 INFO - PROCESS | 17477 | 10:39:18 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:19 INFO - PROCESS | 17477 | RSS: Main: 187547648 10:39:19 INFO - PROCESS | 17477 | 10:39:22 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:22 INFO - PROCESS | 17477 | RSS: Main: 187555840 10:39:22 INFO - PROCESS | 17477 | 10:39:25 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:39:26 INFO - PROCESS | 17477 | RSS: Main: 186920960 10:39:26 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 10:39:28 INFO - PROCESS | 17477 | RSS: Main: 188698624 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | __start_tp_report 10:39:28 INFO - PROCESS | 17477 | _x_x_mozilla_page_load 10:39:28 INFO - PROCESS | 17477 | _x_x_mozilla_page_load_details 10:39:28 INFO - PROCESS | 17477 | |i|pagename|runs| 10:39:28 INFO - PROCESS | 17477 | |0;ai-astar;116;109;114;115;114;114;114;114;115;114 10:39:28 INFO - PROCESS | 17477 | |1;audio-beat-detection;162;133;160;185;132;160;165;134;199;132 10:39:28 INFO - PROCESS | 17477 | |2;audio-dft;161;163;170;161;164;163;164;163;162;161 10:39:28 INFO - PROCESS | 17477 | |3;audio-fft;75;76;77;158;77;75;77;76;154;77 10:39:28 INFO - PROCESS | 17477 | |4;audio-oscillator;88;87;151;89;86;87;136;86;86;137 10:39:28 INFO - PROCESS | 17477 | |5;imaging-gaussian-blur;118;118;118;118;117;118;119;118;117;117 10:39:28 INFO - PROCESS | 17477 | |6;imaging-darkroom;147;148;148;151;149;148;148;148;147;148 10:39:28 INFO - PROCESS | 17477 | |7;imaging-desaturate;96;97;94;96;96;96;95;96;96;96 10:39:28 INFO - PROCESS | 17477 | |8;json-parse-financial;65;65;65;66;65;65;68;65;66;65 10:39:28 INFO - PROCESS | 17477 | |9;json-stringify-tinderbox;65;65;64;64;65;65;67;65;64;65 10:39:28 INFO - PROCESS | 17477 | |10;stanford-crypto-aes;84;84;83;86;91;85;84;85;119;85 10:39:28 INFO - PROCESS | 17477 | |11;stanford-crypto-ccm;135;143;136;133;150;133;141;144;138;135 10:39:28 INFO - PROCESS | 17477 | |12;stanford-crypto-pbkdf2;171;178;174;173;172;169;172;170;164;165 10:39:28 INFO - PROCESS | 17477 | |13;stanford-crypto-sha256-iterative;74;69;68;68;68;66;67;70;67;65 10:39:28 INFO - PROCESS | 17477 | __end_tp_report 10:39:28 INFO - PROCESS | 17477 | __start_cc_report 10:39:28 INFO - PROCESS | 17477 | _x_x_mozilla_cycle_collect,956 10:39:28 INFO - PROCESS | 17477 | __end_cc_report 10:39:28 INFO - PROCESS | 17477 | __startTimestamp1466530768398__endTimestamp 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | ------- Summary: start ------- 10:39:28 INFO - PROCESS | 17477 | Number of tests: 14 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:1.85 (1.6%) stddev-sans-first:1.80 10:39:28 INFO - PROCESS | 17477 | Values: 116.0 109.0 114.0 115.0 114.0 114.0 114.0 114.0 115.0 114.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:161.00 stddev:23.58 (14.6%) stddev-sans-first:24.92 10:39:28 INFO - PROCESS | 17477 | Values: 162.0 133.0 160.0 185.0 132.0 160.0 165.0 134.0 199.0 132.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.66 (1.6%) stddev-sans-first:2.70 10:39:28 INFO - PROCESS | 17477 | Values: 161.0 163.0 170.0 161.0 164.0 163.0 164.0 163.0 162.0 161.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.50 stddev:33.65 (44.0%) stddev-sans-first:35.11 10:39:28 INFO - PROCESS | 17477 | Values: 75.0 76.0 77.0 158.0 77.0 75.0 77.0 76.0 154.0 77.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:86.50 stddev:26.56 (30.7%) stddev-sans-first:27.59 10:39:28 INFO - PROCESS | 17477 | Values: 88.0 87.0 151.0 89.0 86.0 87.0 136.0 86.0 86.0 137.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:39:28 INFO - PROCESS | 17477 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 119.0 118.0 117.0 117.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 10:39:28 INFO - PROCESS | 17477 | Values: 147.0 148.0 148.0 151.0 149.0 148.0 148.0 148.0 147.0 148.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 10:39:28 INFO - PROCESS | 17477 | Values: 96.0 97.0 94.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 10:39:28 INFO - PROCESS | 17477 | Values: 65.0 65.0 65.0 66.0 65.0 65.0 68.0 65.0 66.0 65.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 10:39:28 INFO - PROCESS | 17477 | Values: 65.0 65.0 64.0 64.0 65.0 65.0 67.0 65.0 64.0 65.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:85.00 stddev:10.91 (12.8%) stddev-sans-first:11.44 10:39:28 INFO - PROCESS | 17477 | Values: 84.0 84.0 83.0 86.0 91.0 85.0 84.0 85.0 119.0 85.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:139.50 stddev:5.57 (4.0%) stddev-sans-first:5.74 10:39:28 INFO - PROCESS | 17477 | Values: 135.0 143.0 136.0 133.0 150.0 133.0 141.0 144.0 138.0 135.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:172.00 stddev:4.13 (2.4%) stddev-sans-first:4.38 10:39:28 INFO - PROCESS | 17477 | Values: 171.0 178.0 174.0 173.0 172.0 169.0 172.0 170.0 164.0 165.0 10:39:28 INFO - PROCESS | 17477 | 10:39:28 INFO - PROCESS | 17477 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.49 (3.7%) stddev-sans-first:1.51 10:39:28 INFO - PROCESS | 17477 | Values: 74.0 69.0 68.0 68.0 68.0 66.0 67.0 70.0 67.0 65.0 10:39:28 INFO - PROCESS | 17477 | -------- Summary: end -------- 10:39:28 INFO - PROCESS | 17477 | 10:39:29 INFO - TEST-INFO | 17477: exit 0 10:39:29 INFO - TEST-OK | kraken | took 64890ms 10:39:29 INFO - SUITE-END | took 1181s 10:39:29 INFO - Completed test suite (00:19:41) 10:39:29 INFO - javascript benchmark 10:39:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6357.730452376171, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2595.0, 2625.579907214844, 2646.5236257473657, 2647.2720001999446, 2661.414488812462, 4577.267637178048, 4614.3539904413365, 4626.514216007321, 4722.150012997659, 4747.28790681398, 4633.49031606523, 4659.0, 4666.953330466695, 4697.6241900647865, 4725.291206319045, 4252.723572967755, 4338.479382474107, 4377.715448495837, 4398.516163222059, 4398.736075835444, 557.3908532721388, 4239.2793225151645, 4351.129774045188, 4355.259605866994, 4401.031773009932, 4273.038566322568, 4310.43964284641, 4320.071184695305, 4340.240457919851, 4348.869533913956, 4241.724287921306, 4297.312430011183, 4317.395564620955, 4318.3090705486975, 4363.454568178978, 4257.510386305584, 4304.053108316165, 4321.0709697414895, 4322.848700295506, 4329.19909816685, 4722.76386180693, 4756.97724989129, 4788.401449818773, 4792.305115758196, 4810.237864514106, 5122.462141475166, 5167.715775632339, 5181.300524429192, 5187.299714538527, 5241.266222728821, 5225.947740522623, 5226.111561034595, 5228.215767634847, 5228.764705588258, 5268.078086334915, 4837.298591704183, 4873.658843880929, 4878.829240976549, 4883.365162528919, 4888.095702295087, 5247.842564723064, 5264.763085661154, 5307.65500242483, 5319.521243088141, 5333.466653334635, 5103.693778373309, 5114.539691427789, 5117.360329958755, 5131.640785145004, 5169.586433085344, 4978.402591688948, 5210.322658054429, 5212.791488340424, 5214.556762675139, 5220.973895130576, 5023.8492845214705, 5036.294918711384, 5079.548683994031, 5079.644424890223, 5107.412647545506, 4864.951350486521, 4970.229614409773, 4989.301497790312, 5038.345015148007, 5044.0, 4109.4246805447265, 4210.5157906840495, 4219.620234178878, 4232.555581663881, 4277.123189746095, 3704.2776658551325, 3718.7768733876055, 3729.4965179700935, 3772.39641657339, 3809.3143234218105, 4453.087117140978, 4490.0, 4494.258447356149, 4494.303382975644, 4532.660050496226, 5032.72320022395, 5097.46476619957, 5123.538881500608, 5152.252923326097, 5181.533661970366, 4436.511983681792, 4449.7775111244955, 4450.933236001462, 4479.7536135512855, 4492.932606010912, 4484.1031793641405, 4528.88677783058, 4535.297028960516, 4537.251353526697, 4589.472210695746, 4793.28100784892, 4796.5203479651755, 4810.5670489656095, 4815.374001379798, 4824.589909857701, 5102.387713474407, 5140.049090918043, 5142.1772516397195, 5147.2536482209125, 5154.819581314786, 4678.368420263221, 4816.229403295456, 4863.221884498464, 4874.463808980939, 4904.2643603459765, 5005.274235235943, 5023.120953833138, 5063.0, 5079.898402032012, 5081.0, 5133.922991155061, 5163.328767260232, 5169.53474187325, 5172.069027574922, 5174.390207434179, 4864.367632207932, 4882.731449770296, 4984.22744474607, 5013.348264725562, 5015.623828212826, 4860.416749990024, 4863.95136048635, 4878.317035615088, 4936.9259461107395, 4974.502549744997, 4849.75751212445, 4866.48901865299, 4875.658703890694, 4927.704337739604, 4936.234883593049, 4892.119418504561, 4945.357103576512, 5027.32131162303, 5035.773390197523, 5093.617978651542, 4890.144224760582, 4910.8281210157475, 4916.803327866845, 4929.457759646364, 4976.452590215001], "value": 4650.812588504638, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.136886665768, 581.482480592273, 594.5184400635486, 611.8653896142847, 614.1647359590955, 35019.47470787937, 38675.22649547011, 38708.225835483274, 38797.80601096997, 38876.80561597191, 39052.0, 39505.209895802065, 39715.20569588606, 39751.40372894409, 39971.40042899359, 7645.961770191155, 7851.45039847211, 7857.1357150713375, 7858.253465920729, 7863.252990965849, 7558.886616700754, 7564.281393267631, 7575.0, 7581.810454738648, 7623.047119110111, 7596.0, 7606.087269527665, 7650.426218033642, 7653.425993050543, 7675.424343174256, 7612.162662107219, 7627.237276272356, 7650.464467487306, 7652.617369131549, 7652.69389224436, 7838.76483705484, 7859.331956783681, 7912.841743165162, 7920.009998750156, 7921.128675845653, 29657.40685186306, 37722.0, 37854.62145378539, 37917.62082379169, 38112.80943595292, 2875.07997440819, 2905.680375158731, 2967.4806908790874, 3115.1589070950945, 3391.8134502602347, 28057.579136312972, 30038.098857034325, 30486.085417437513, 30545.541816872767, 30555.23611909698, 3485.1112966193714, 3570.3751843427294, 3587.7667951583326, 3593.3531964246426, 3597.460380942853, 265585.0, 268177.999999998, 268675.0, 269477.0, 270608.0, 55448.168277475874, 57090.0, 57162.42837571654, 57198.0, 57223.71388143116, 51570.484295157316, 58351.41648583545, 59937.0, 60202.0, 60605.39394606086, 12934.0, 12994.155379900276, 13018.89339406142, 13036.54372096991, 13121.409536570687, 9929.553170107363, 9969.55137018836, 9984.700458986243, 10026.548805303779, 10042.49787510636, 18309.176087076114, 18446.81553184451, 18452.26190952374, 18552.44342669722, 18680.0, 6855.760048398282, 6934.341237582422, 6995.650217489105, 7038.718451261994, 7143.39273663432, 781.2421950707804, 876.1895246896722, 900.5497251374313, 948.62055177928, 971.3831716859704, 27152.0, 28405.147845564665, 28545.714542854304, 28678.0, 28844.567331490045, 903.1961554216753, 926.8424367857481, 934.9953250233841, 980.313780353741, 1026.030401270792, 13759.17444953306, 14114.576562703136, 14284.0, 14460.20468874222, 14495.492657757139, 405990.0, 412924.0, 413776.0, 414291.0, 417744.0, 47834.76082619565, 48294.758526207144, 48393.516064839605, 48483.0, 48658.75670621695, 1147.3230793831679, 1178.3283528388909, 1178.5757127434117, 1179.097990037622, 1207.8610959739567, 25464.236072917844, 26666.200013999613, 26761.197164085108, 27202.31994200161, 27219.59170612403, 40340.79829600833, 40443.0, 41239.587604123575, 41349.586504134575, 41383.793081034404, 373981.0, 374768.0, 374911.0, 375408.0, 375492.0, 24790.752092479564, 25250.116245931305, 25265.368365791, 25279.0, 25297.87351063233, 39972.40041399323, 39997.0, 40200.39699404453, 40842.0, 41127.38308925428, 33795.493067603515, 34308.48537271993, 34725.0, 35068.14250432501, 35502.28995420129, 34206.486902696975, 34609.48085778665, 34692.30615387628, 34824.0, 35265.47101793424, 29457.410851783272, 34285.0, 34329.48505772366, 34501.827490862386, 34687.653123468444, 29164.70835291705, 31341.52987705232, 31507.52738708967, 31556.36887262288, 31900.840495797373, 25029.249122526355, 25231.864566094202, 25406.618900716872, 25413.74586254114, 25686.0], "value": 17401.53218503799, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.61826318891553, 372.84340576957675, 373.9308227977824, 377.09309111586634, 389.9961000389997, 15477.845221547781, 15891.0, 17023.489295321127, 17044.14779261035, 17052.23264953077, 15598.922005389957, 15683.529494115166, 16802.66394672106, 16866.156692165372, 16892.493225203263, 5152.0, 5267.683938963674, 5316.12283973144, 5323.893522129574, 5357.464253574631, 4838.346823178878, 5237.869053273661, 5288.6562373445795, 5298.23175639532, 5311.73441327934, 5108.1060814357525, 5233.842984710445, 5236.2931004314505, 5237.266782650432, 5241.711705856176, 5086.237064440345, 5155.948440515603, 5158.7420628968775, 5164.302819119408, 5176.249443830642, 5170.379554453452, 5261.97391508656, 5264.184051472028, 5298.125809241471, 5299.099153143975, 17604.471865844047, 18648.160832762558, 18696.81303186978, 19118.0, 20502.38492845217, 1717.4332470284776, 1746.8253174682557, 1850.824171703686, 1865.2632210277, 1878.4176905159309, 8047.637856296422, 8510.574471276474, 8733.650653973833, 9892.802143957153, 13663.658408539766, 1526.450477827981, 1609.6378314879175, 1759.2347328911965, 1762.8060913299528, 1769.3630293094475, 60730.0, 61753.382466175215, 63249.36750632481, 63345.29892309714, 63656.999999999534, 8173.346132309401, 8761.474311541328, 8903.599338029804, 8911.019787823334, 9081.409708369067, 11492.310461372344, 11496.137789665809, 11559.266110083554, 11577.0, 11616.535338586362, 6560.770373036921, 6632.668366581748, 6774.898376524356, 6813.591184528944, 6823.283555226729, 6339.144215530937, 6409.359064093554, 6511.706973186123, 6653.534252602271, 6664.700088496029, 3626.6192049834917, 3664.4686520454916, 3728.440733889884, 3799.0502374406396, 3870.825812838429, 1668.3410053028986, 1679.2443400469838, 1756.5432987423108, 1769.8672599555084, 1778.084286592406, 805.2350267246139, 835.0814104485017, 856.0369584217755, 875.2166810704384, 909.340727972228, 17014.234359453854, 17282.481525554, 17449.12754362277, 17486.21312040961, 17759.822401776077, 832.1678321678322, 842.1304703558092, 863.887694599698, 865.6191275838611, 868.444195714743, 9434.3867648604, 9608.807823843485, 9639.18066964302, 9658.179054780281, 9754.904895914438, 366312.0, 383000.0, 383797.0, 385969.0, 386203.0, 57822.0, 69367.30632693609, 69431.65284173648, 71851.64074179596, 72768.0, 886.2334081019872, 906.1799071839995, 922.7693076730683, 932.1470854168496, 935.7286386947709, 15526.9223653881, 15621.843781562493, 15807.0, 16150.515484535483, 16237.269322880262, 34830.47754283738, 35711.82144089263, 36087.819560902026, 36411.45382819313, 36633.816830915675, 46156.0, 50542.0, 51363.743181283855, 51418.0, 51715.0, 7484.700611975678, 7583.469157158946, 7657.851322301476, 7675.232476752503, 7710.92289077102, 10562.683119506428, 11764.235324703866, 11863.525458981889, 11994.160408771651, 12022.699432513908, 8966.327525435488, 9007.0, 9234.1689247968, 9629.759256018375, 9782.853257201004, 8757.343199260209, 10174.287799853939, 10232.0, 10291.53688084023, 10411.84382234252, 8997.515409957283, 9130.817383652156, 10050.19598432109, 10282.897171028193, 10324.690259292232, 7504.212057733859, 7525.849483010418, 7705.113911900204, 7707.421943354383, 7807.726729564438, 7453.2546745325035, 9503.239740820856, 9894.307398482037, 10018.499075046364, 10122.0], "value": 7886.809756423928, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.7083077138416, 1408.4999825062102, 1446.6094154578263, 1613.3949768836694, 1619.2875134940632, 6808.080909077273, 7440.702371905118, 7531.774046778592, 8176.305014073796, 8188.549629770368, 7537.09554853417, 7790.571518566477, 7853.37173026158, 7855.13593504714, 7891.960540197305, 2181.879996600186, 2225.4547635829244, 2226.8329875259337, 2229.8104661103744, 2241.4508445430893, 2145.5279838435517, 2190.321000489845, 2210.071769856664, 2210.557888422314, 2215.0475295622878, 2153.655415133579, 2170.598439288729, 2171.761106278308, 2173.869567825928, 2185.89070546472, 2124.2989813361633, 2134.7758485359122, 2136.465883529118, 2136.583366243583, 2144.453164443057, 2131.7441906971108, 2179.978200218009, 2181.4873504726374, 2198.219632030622, 2203.4271089516683, 7730.690772369098, 7829.530228186327, 7849.882251766228, 7859.52842829432, 7860.449768516206, 4544.636429085665, 4585.7248565085865, 4604.815807367735, 4613.331066995301, 4637.026224492861, 2788.9721102788917, 2873.913782586526, 2964.0, 2979.970200297991, 2983.9403211935855, 900.7252787899688, 904.6155383961856, 944.0795224655974, 944.8063147054906, 950.021477877787, 10531.210159238011, 10559.630412935587, 10644.733881652943, 10748.355098694024, 10751.569937202503, 4115.71190016702, 4181.435506206684, 4265.168292183057, 4279.786010699452, 4298.2263192625005, 9153.679621213225, 9176.95411522938, 9189.770255743526, 9271.07289271081, 9288.303377246733, 4730.692504987165, 4742.73914934675, 4745.3593764842, 4745.525447455296, 4745.83389581363, 3695.0, 4148.522919864255, 4231.894202644959, 4289.420928174656, 4319.136172765459, 3578.4095624221713, 3631.0, 3715.0898029982286, 3749.7937613431523, 3823.923521529554, 1184.549871049013, 1209.4194786502528, 1213.5995121610024, 1217.4947396830216, 1219.6584956212275, 687.4225650453643, 819.3568049081442, 819.9139090395541, 845.9577021149041, 847.5931552854664, 5095.439501654815, 5305.336832895888, 5348.679079255257, 5351.678899266057, 5370.087085195526, 399.7062159312903, 405.78087832570674, 409.08977525007214, 414.1654566049413, 414.2770864840872, 3626.637336266352, 3669.174435751988, 3703.814809259526, 3735.34631439497, 3750.6999440044733, 9404.90595094054, 9693.660721874841, 9731.756706082404, 9826.852597211047, 9874.950625246971, 9648.614055437843, 9701.223902087817, 9702.466364349888, 9710.320277580502, 9740.853887191697, 7001.614911179934, 7216.639168041577, 7243.60160191184, 7322.487425880244, 7331.450141239428, 5072.239164125411, 5092.949070509248, 5106.565941894981, 5230.398504172069, 5272.499112584298, 8791.648334066565, 8878.0, 8996.775080623036, 9104.044075372256, 9125.722398864296, 8930.642774289216, 9270.675526356816, 9271.6291348348, 9302.488363140092, 9322.720318390458, 6021.819345419644, 6559.278479367361, 6772.898406524005, 6795.626240556817, 6918.273581273894, 7422.443316751157, 7497.812554686177, 7515.286047825448, 7559.470837041575, 7562.810929726801, 6580.7038683260325, 6615.338466153538, 6621.966890165519, 6745.392914637706, 6886.070380498769, 6874.862502749817, 6891.689873955584, 6898.758543450955, 6950.374466298057, 6972.6862291196, 6035.426634469718, 6063.575549711654, 6065.332813390612, 6084.787032453843, 6105.664188469676, 4512.278035514302, 4564.383808185985, 4660.510646382217, 4683.461401938821, 4687.578117969263, 4424.535423780457, 4454.175977444053, 4514.796834142538, 4695.812167513262, 4779.856604301876], "value": 4066.464904583567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.8608910767386, 302.455579956079, 307.7937781686273, 310.19040304804463, 316.94453470642634, 4748.738819364942, 4749.319277559893, 4895.877603059926, 4963.726995015273, 5003.399592048954, 4839.733814640203, 4863.586595139409, 4889.877753056176, 4891.8777030574165, 4937.679050861691, 3862.4206369044587, 3866.439366291886, 3882.9223415531674, 3883.2233553289316, 3891.824867880938, 3793.525809273841, 3886.553046399672, 3886.8639597614088, 3916.0, 3916.941245881314, 3778.886633401002, 3855.7108216883707, 3874.9806250968704, 3877.2827026999953, 3881.4177873319086, 3814.9618503814886, 3815.1606646537857, 3823.9808800955816, 3834.5973672764517, 3871.8838434847, 3420.572428446444, 3444.328355970587, 3447.1382154461385, 3448.7241020718284, 3455.4298540740747, 4737.549932756383, 4827.782749776268, 4840.806367745286, 4891.168501354743, 4915.631327650441, 4444.644428445717, 4452.46389995451, 4461.992103553382, 4476.664250181217, 4489.124620698965, 5192.169252919514, 5219.060569097561, 5237.816676416307, 5244.842654720364, 5247.632665713401, 3717.2937141943216, 3783.6027217142077, 3813.7139714521522, 3820.465134881119, 3832.329342365075, 5418.485243901862, 5459.153831156177, 5466.699331536764, 5478.260434841285, 5483.917741233885, 3844.3272427325105, 3865.8067096645054, 3872.9806350968065, 3874.4188371744463, 3883.223355328889, 3933.4099885016903, 3937.350337194388, 3942.1918506706056, 3942.586028467027, 3952.7233093683167, 4287.370799096323, 4398.846040388571, 4426.336049592587, 4427.180971520279, 4436.8447104351835, 5157.252198431206, 5193.324867767166, 5208.817691380859, 5224.895502089937, 5226.529612334908, 1278.7314663920681, 1329.4947919790418, 1361.6187467509114, 1365.8458602480887, 1367.8426980897125, 880.335346813152, 882.4131952251809, 896.2561074308309, 908.52756566585, 911.2163539356148, 4094.8566800161852, 4107.843382224356, 4112.0, 4117.485314335708, 4164.958350416457, 4710.364100846342, 4755.5482229188865, 4756.075013866516, 4779.689320194177, 4794.616430685537, 4071.42999980003, 4118.19695159441, 4126.5667104953545, 4130.938035929404, 4157.417961485395, 2571.768540831297, 2669.8131130820657, 2905.898293559715, 2911.8252904825777, 2915.489789286909, 5097.847064588068, 5137.280780690707, 5144.279800827887, 5146.588272938156, 5196.53231209193, 5292.20616907467, 5506.862328441821, 5597.776088956396, 5599.944000559943, 5617.0, 5072.376839411427, 5089.167899556157, 5100.770465329069, 5107.79568817258, 5117.822900732778, 5342.332208473941, 5426.647267927572, 5437.483439073281, 5442.782288708566, 5458.0, 5040.773165207501, 5300.2049692546425, 5305.575553955597, 5324.988252232063, 5350.652207606493, 5053.772580233825, 5080.390353157644, 5086.847394578021, 5110.441315398691, 5143.691378517301, 3812.8856134316015, 3831.63599458051, 3833.6933045356864, 3834.8657796978086, 3878.204967981613, 5211.5049070338255, 5280.234366016983, 5426.267453893832, 5435.429279925551, 5452.618316717951, 5225.137852254487, 5249.160134378481, 5264.657797243167, 5272.393674727456, 5294.682319060868, 5269.736513174403, 5270.8155214567305, 5276.736163191902, 5280.102382595045, 5308.362996440452, 4908.877278067934, 5165.509276618715, 5168.8449346519665, 5202.3497062867145, 5209.348831396075, 5256.579473642023, 5263.0, 5265.60507961912, 5288.206768984529, 5295.920561191662, 5147.58819294448, 5164.340364712101, 5165.92251116226, 5177.0, 5179.896402072013], "value": 3910.1257131934744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.88305987982, 716.2550947015104, 727.4689476682022, 747.1333253426027, 771.6836097200149, 12611.18027328223, 13239.0, 13324.733505329912, 13365.7326853463, 13456.596302110927, 12917.870821291785, 13156.868431315685, 13391.263480508567, 13406.262655553941, 13454.663633409169, 783.6356094416095, 785.3873978296938, 787.9606019699021, 788.5071830106184, 789.34090034821, 777.4014009212902, 781.6443518199205, 782.0341877780965, 782.3350152370468, 783.4946459533597, 805.6414895371562, 811.0227176252631, 811.1888111888112, 812.6627449608405, 812.6830536090929, 796.0288448093346, 800.2597597222546, 802.5345299726145, 806.0931452116369, 807.1887752808449, 583.1456915618639, 588.3675049321953, 589.0016422164433, 590.5246276747217, 590.6898878088995, 12159.756804863942, 12262.38688065602, 12267.69330766729, 12378.257304561665, 12383.690407739788, 10955.233133680646, 11006.0, 11038.889611103867, 11147.275427097295, 11406.31562106268, 9491.098345657152, 9514.714558563253, 9588.856167157499, 9658.855117173249, 9762.56068476913, 3259.429599820022, 3318.8451255395516, 3341.7827841190247, 3345.9498107528407, 3377.8817741378934, 41111.1777764443, 52689.2096618551, 52933.735331323485, 57933.0, 59808.70095649538, 10621.1352465515, 10666.200034997406, 10711.73220669474, 10792.622258220925, 10926.289791163548, 19574.412767616996, 19582.118804653826, 19584.21663133487, 19606.509837254183, 19691.212351506067, 7116.64416779159, 7130.714771409085, 7212.855742885218, 7259.2377800330205, 7303.780886573411, 3662.8278950735507, 3745.8127093645753, 3787.715921305858, 3833.884983450501, 3838.808059597009, 2943.67619561848, 3031.6362036555756, 3052.069118918751, 3053.6793636668276, 3057.969420305813, 517.1286382445516, 521.6322492642678, 533.3280067115462, 539.3096836049863, 539.5144370066971, 474.68511232893167, 551.4292707048186, 571.1632458448393, 578.7135367992786, 586.8327526654969, 7410.962945185347, 7609.467337286337, 7630.160682324939, 7697.384209263358, 8184.836303273901, 429.02611072864426, 553.720371212535, 563.5207580102232, 567.336216626548, 567.6764244380663, 3519.260955199437, 3642.85428582859, 3705.4997575326984, 3786.091338078841, 3864.9806750966627, 95900.52049739847, 96673.0, 97036.0, 99398.0, 99956.50021749844, 56243.0, 69593.3040669597, 82733.0, 82960.58519707483, 84073.0, 72983.63508182531, 75711.62144189244, 75835.62082189554, 75867.0, 78058.89465111945, 8399.790005249673, 8672.653093876173, 8751.737447876574, 8761.518116503654, 8789.912100879164, 42013.78993105015, 42201.78899105485, 42226.155476889675, 42328.57671423246, 42740.0, 61681.0, 63161.0, 63169.0, 63464.36535634584, 63834.3616563847, 11479.196456247982, 11649.136138217844, 11672.182947193614, 11710.70723231926, 12092.0, 12782.61652150437, 12973.22160670325, 12988.701129886937, 13677.726445470837, 13753.724925501234, 11383.601573944872, 11716.121290903387, 11994.520219191134, 12243.75512489763, 12293.815592766294, 11563.248388854698, 11579.652610421701, 11642.126840486828, 11901.10741694359, 12171.573994910135, 11553.537858485903, 11574.421278936188, 11886.940565297118, 12143.696407589881, 12397.256164630151, 10374.619643836922, 10500.422476763852, 10735.516901739597, 10836.566537338733, 10911.836322455329, 9597.184239339735, 9805.607775688892, 9845.704628861145, 9867.506624668882, 9879.703608891745], "value": 6506.374794451189, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 160.0, 185.0, 132.0, 160.0, 165.0, 134.0, 199.0, 132.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 170.0, 161.0, 164.0, 163.0, 164.0, 163.0, 162.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 158.0, 77.0, 75.0, 77.0, 76.0, 154.0, 77.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 151.0, 89.0, 86.0, 87.0, 136.0, 86.0, 86.0, 137.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 119.0, 118.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 151.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 94.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 68.0, 65.0, 66.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 67.0, 65.0, 64.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 86.0, 91.0, 85.0, 84.0, 85.0, 119.0, 85.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 143.0, 136.0, 133.0, 150.0, 133.0, 141.0, 144.0, 138.0, 135.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 178.0, 174.0, 173.0, 172.0, 169.0, 172.0, 170.0, 164.0, 165.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 68.0, 68.0, 68.0, 66.0, 67.0, 70.0, 67.0, 65.0], "value": 68.2, "unit": "score"}]}]} 10:39:29 INFO - Return code: 0 10:39:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:39:29 ERROR - # TBPL SUCCESS # 10:39:29 INFO - Running post-action listener: _resource_record_post_action 10:39:29 INFO - ##### 10:39:29 INFO - ##### Finished run-tests step (success) 10:39:29 INFO - ##### 10:39:29 INFO - Running post-run listener: _resource_record_post_run 10:39:29 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 312672256; Read time: 8; Write time: 159868 10:39:29 INFO - TinderboxPrint: CPU usage
13.4% 10:39:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:39:29 INFO - TinderboxPrint: I/O write bytes / time
312,672,256 / 159,868 10:39:29 INFO - TinderboxPrint: CPU idle
8,275.8 (86.5%) 10:39:29 INFO - TinderboxPrint: CPU user
1,234.0 (12.9%) 10:39:29 INFO - TinderboxPrint: Swap in / out
0 / 0 10:39:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 19652608; Read time: 0; Write time: 12320 10:39:29 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291774464; Read time: 8; Write time: 147420 10:39:30 INFO - Running post-run listener: _upload_blobber_files 10:39:30 INFO - Blob upload gear active. 10:39:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:39:30 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:39:30 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:39:30 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:39:30 INFO - (blobuploader) - INFO - Open directory for files ... 10:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:39:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:31 INFO - (blobuploader) - INFO - Done attempting. 10:39:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:39:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:39:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:32 INFO - (blobuploader) - INFO - Done attempting. 10:39:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:39:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:36 INFO - (blobuploader) - INFO - Done attempting. 10:39:36 INFO - (blobuploader) - INFO - Iteration through files over. 10:39:36 INFO - Return code: 0 10:39:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:39:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:39:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a832b9b7f4eda2920146cf4d87252691e4b85b1c7ef8249dbbf463d2e230a26570e60bf1cbf0587dc4295dfc5e03c2cbe90167ed35a8c90052244b57b2d4453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a069c81668fe145a422bb12b8cee1b086eea238ffb4682518bbf07b0be4414a7ab80948f7b2d5f6bc936edf77017d558d85fc50436b09eef80136f26d192de0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d87e9c9016b2bd259670eff59503738ab25298379f63cdec395f1e89ac6e1510518db600f0409cc455f34389c557c1d73148b2a938cae61b28e7079ec55f5307"} 10:39:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:39:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:39:36 INFO - Contents: 10:39:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a832b9b7f4eda2920146cf4d87252691e4b85b1c7ef8249dbbf463d2e230a26570e60bf1cbf0587dc4295dfc5e03c2cbe90167ed35a8c90052244b57b2d4453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a069c81668fe145a422bb12b8cee1b086eea238ffb4682518bbf07b0be4414a7ab80948f7b2d5f6bc936edf77017d558d85fc50436b09eef80136f26d192de0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d87e9c9016b2bd259670eff59503738ab25298379f63cdec395f1e89ac6e1510518db600f0409cc455f34389c557c1d73148b2a938cae61b28e7079ec55f5307"} 10:39:36 INFO - Running post-run listener: copy_logs_to_upload_dir 10:39:36 INFO - Copying logs to upload dir... 10:39:36 INFO - mkdir: /builds/slave/test/build/upload/logs 10:39:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.442003 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-06-21 10:39:36.808793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 10:39:36.811953) ========= 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=7de08804244eb36560b44971000001c3-1466528662.338014-2147016368 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-Non-PGO/sha512/1a832b9b7f4eda2920146cf4d87252691e4b85b1c7ef8249dbbf463d2e230a26570e60bf1cbf0587dc4295dfc5e03c2cbe90167ed35a8c90052244b57b2d4453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a069c81668fe145a422bb12b8cee1b086eea238ffb4682518bbf07b0be4414a7ab80948f7b2d5f6bc936edf77017d558d85fc50436b09eef80136f26d192de0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d87e9c9016b2bd259670eff59503738ab25298379f63cdec395f1e89ac6e1510518db600f0409cc455f34389c557c1d73148b2a938cae61b28e7079ec55f5307"} build_url:https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/MXEeOF6oQ0Ojlbe6oyl37w/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-Non-PGO/sha512/1a832b9b7f4eda2920146cf4d87252691e4b85b1c7ef8249dbbf463d2e230a26570e60bf1cbf0587dc4295dfc5e03c2cbe90167ed35a8c90052244b57b2d4453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a069c81668fe145a422bb12b8cee1b086eea238ffb4682518bbf07b0be4414a7ab80948f7b2d5f6bc936edf77017d558d85fc50436b09eef80136f26d192de0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d87e9c9016b2bd259670eff59503738ab25298379f63cdec395f1e89ac6e1510518db600f0409cc455f34389c557c1d73148b2a938cae61b28e7079ec55f5307"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 10:39:36.837444) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 10:39:36.837778) ========= 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=7de08804244eb36560b44971000001c3-1466528662.338014-2147016368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 10:39:36.925316) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 10:39:36.925638) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 10:39:36.925933) ========= ========= Total master_lag: 0.18 =========