builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1465310635.83 results: success (0) buildid: 20160607062931 builduid: e5181fa809be4ec3b0547efd89456d65 revision: 7f7c7d24700eb80ce328b05fd260ec58e9725ca4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:55.826472) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:55.827588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:55.828315) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:55.845852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:55.846416) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 07:43:55-- 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% 221M=0s 2016-06-07 07:43:56 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094210 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:55.955878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:55.956259) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019105 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:56.006263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 07:43:56.006659) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7f7c7d24700eb80ce328b05fd260ec58e9725ca4 --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 7f7c7d24700eb80ce328b05fd260ec58e9725ca4 --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=20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 07:43:56,141 truncating revision to first 12 chars 2016-06-07 07:43:56,141 Setting DEBUG logging. 2016-06-07 07:43:56,141 attempt 1/10 2016-06-07 07:43:56,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7f7c7d24700e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 07:43:57,348 unpacking tar archive at: mozilla-central-7f7c7d24700e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.508170 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 07:43:57.529785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:57.530175) ========= script_repo_revision: 7f7c7d24700eb80ce328b05fd260ec58e9725ca4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:57.530643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:57.530950) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 07:43:57.542531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-07 07:43:57.543200) ========= /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=20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:43:57 INFO - MultiFileLogger online at 20160607 07:43:57 in /builds/slave/test 07:43:57 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 07:43:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:43:57 INFO - {'append_to_log': False, 07:43:57 INFO - 'base_work_dir': '/builds/slave/test', 07:43:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:43:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:43:57 INFO - 'branch': 'Firefox-Non-PGO', 07:43:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:43:57 INFO - 'config_files': ('talos/linux_config.py',), 07:43:57 INFO - 'default_actions': ('clobber', 07:43:57 INFO - 'read-buildbot-config', 07:43:57 INFO - 'download-and-extract', 07:43:57 INFO - 'populate-webroot', 07:43:57 INFO - 'create-virtualenv', 07:43:57 INFO - 'install', 07:43:57 INFO - 'run-tests'), 07:43:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:43:57 INFO - 'download_minidump_stackwalk': True, 07:43:57 INFO - 'download_symbols': 'ondemand', 07:43:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:43:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:43:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:43:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:43:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:43:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:43:57 INFO - 'installer_path': 'installer.exe', 07:43:57 INFO - 'log_level': 'info', 07:43:57 INFO - 'log_name': 'talos', 07:43:57 INFO - 'log_to_console': True, 07:43:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:43:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:43:57 INFO - 'opt_config_files': (), 07:43:57 INFO - 'pip_index': False, 07:43:57 INFO - 'sps_profile': False, 07:43:57 INFO - 'sps_profile_interval': 0, 07:43:57 INFO - 'suite': 'dromaeojs-e10s', 07:43:57 INFO - 'system_bits': '32', 07:43:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:43:57 INFO - 'title': 'talos-linux64-ix-015', 07:43:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:43:57 INFO - 'use_talos_json': True, 07:43:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:43:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:43:57 INFO - 'work_dir': 'build'} 07:43:57 INFO - ##### 07:43:57 INFO - ##### Running clobber step. 07:43:57 INFO - ##### 07:43:57 INFO - Running pre-action listener: _resource_record_pre_action 07:43:57 INFO - Running main action method: clobber 07:43:57 INFO - rmtree: /builds/slave/test/build 07:43:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:43:58 INFO - Running post-action listener: _resource_record_post_action 07:43:58 INFO - ##### 07:43:58 INFO - ##### Finished clobber step (success) 07:43:58 INFO - ##### 07:43:58 INFO - ##### 07:43:58 INFO - ##### Running read-buildbot-config step. 07:43:58 INFO - ##### 07:43:58 INFO - Running pre-action listener: _resource_record_pre_action 07:43:58 INFO - Running main action method: read_buildbot_config 07:43:58 INFO - Using buildbot properties: 07:43:58 INFO - { 07:43:58 INFO - "project": "", 07:43:58 INFO - "product": "firefox", 07:43:58 INFO - "script_repo_revision": "production", 07:43:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:43:58 INFO - "repository": "", 07:43:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:43:58 INFO - "buildid": "20160607062931", 07:43:58 INFO - "pgo_build": "False", 07:43:58 INFO - "basedir": "/builds/slave/test", 07:43:58 INFO - "buildnumber": 371, 07:43:58 INFO - "slavename": "talos-linux64-ix-015", 07:43:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:43:58 INFO - "platform": "ubuntu64_hw", 07:43:58 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:43:58 INFO - "branch": "mozilla-central", 07:43:58 INFO - "repo_path": "mozilla-central", 07:43:58 INFO - "revision": "7f7c7d24700eb80ce328b05fd260ec58e9725ca4", 07:43:58 INFO - "stage_platform": "linux64", 07:43:58 INFO - "builduid": "e5181fa809be4ec3b0547efd89456d65", 07:43:58 INFO - "slavebuilddir": "test" 07:43:58 INFO - } 07:43:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:43:58 INFO - Running post-action listener: _resource_record_post_action 07:43:58 INFO - ##### 07:43:58 INFO - ##### Finished read-buildbot-config step (success) 07:43:58 INFO - ##### 07:43:58 INFO - ##### 07:43:58 INFO - ##### Running download-and-extract step. 07:43:58 INFO - ##### 07:43:58 INFO - Running pre-action listener: _resource_record_pre_action 07:43:58 INFO - Running main action method: download_and_extract 07:43:58 INFO - mkdir: /builds/slave/test/build/tests 07:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:58 INFO - https://queue.taskcluster.net/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:43:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:43:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:43:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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 07:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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 07:43:58 INFO - Downloaded 1361 bytes. 07:43:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:43:58 INFO - Using the following test package requirements: 07:43:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:43:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:43:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:43:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:58 INFO - u'jsshell-linux-x86_64.zip'], 07:43:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:43:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:43:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:43:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:43:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:43:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:43:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:58 INFO - https://queue.taskcluster.net/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:43:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:43:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:43:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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 07:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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 07:44:00 INFO - Downloaded 22873594 bytes. 07:44:00 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'] 07:44:00 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 07:44:01 INFO - Return code: 0 07:44:01 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 07:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:01 INFO - https://queue.taskcluster.net/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:44:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:44:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:44:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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 07:44:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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 07:44:02 INFO - Downloaded 22873594 bytes. 07:44:02 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'] 07:44:02 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 07:44:03 INFO - Return code: 0 07:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:03 INFO - https://queue.taskcluster.net/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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 07:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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 07:44:04 INFO - Downloaded 10833369 bytes. 07:44:04 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'] 07:44:04 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 07:44:05 INFO - Return code: 0 07:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:05 INFO - https://queue.taskcluster.net/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:44:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:44:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:44:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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 07:44:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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 07:44:06 INFO - Downloaded 55204146 bytes. 07:44:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:44:06 INFO - mkdir: /builds/slave/test/properties 07:44:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:44:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:44:06 INFO - Contents: 07:44:06 INFO - build_url:https://queue.taskcluster.net/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:44:07 INFO - Running post-action listener: _resource_record_post_action 07:44:07 INFO - Running post-action listener: set_extra_try_arguments 07:44:07 INFO - ##### 07:44:07 INFO - ##### Finished download-and-extract step (success) 07:44:07 INFO - ##### 07:44:07 INFO - ##### 07:44:07 INFO - ##### Running populate-webroot step. 07:44:07 INFO - ##### 07:44:07 INFO - Running pre-action listener: _resource_record_pre_action 07:44:07 INFO - Running main action method: populate_webroot 07:44:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:44:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:44:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:44:07 INFO - '--tppagecycles', 07:44:07 INFO - '7'], 07:44:07 INFO - 'tests': ['tsvgm']}}, 07:44:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:44:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:44:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:44:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:44:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:44:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:44:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:07 INFO - 'talos_options': ['--disable-e10s'], 07:44:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:07 INFO - 'talos_options': ['--disable-e10s'], 07:44:07 INFO - 'tests': ['damp', 'tps']}, 07:44:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:07 INFO - 'tests': ['damp', 'tps']}, 07:44:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:44:07 INFO - 'tests': ['dromaeo_dom']}, 07:44:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:44:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:44:07 INFO - 'tests': ['a11yr', 07:44:07 INFO - 'ts_paint', 07:44:07 INFO - 'tpaint', 07:44:07 INFO - 'sessionrestore', 07:44:07 INFO - 'sessionrestore_no_auto_restore', 07:44:07 INFO - 'tabpaint']}, 07:44:07 INFO - 'other-e10s': {'tests': ['a11yr', 07:44:07 INFO - 'ts_paint', 07:44:07 INFO - 'tpaint', 07:44:07 INFO - 'sessionrestore', 07:44:07 INFO - 'sessionrestore_no_auto_restore', 07:44:07 INFO - 'tabpaint']}, 07:44:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:44:07 INFO - 'ts_paint', 07:44:07 INFO - 'tpaint', 07:44:07 INFO - 'sessionrestore', 07:44:07 INFO - 'sessionrestore_no_auto_restore', 07:44:07 INFO - 'tabpaint']}, 07:44:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:44:07 INFO - 'ts_paint', 07:44:07 INFO - 'tpaint', 07:44:07 INFO - 'sessionrestore', 07:44:07 INFO - 'sessionrestore_no_auto_restore', 07:44:07 INFO - 'tabpaint']}, 07:44:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:44:07 INFO - 'tests': ['a11yr', 07:44:07 INFO - 'ts_paint', 07:44:07 INFO - 'tpaint', 07:44:07 INFO - 'sessionrestore', 07:44:07 INFO - 'sessionrestore_no_auto_restore', 07:44:07 INFO - 'tabpaint']}, 07:44:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:44:07 INFO - 'tests': ['a11yr', 07:44:07 INFO - 'ts_paint', 07:44:07 INFO - 'tpaint', 07:44:07 INFO - 'sessionrestore', 07:44:07 INFO - 'sessionrestore_no_auto_restore', 07:44:07 INFO - 'tabpaint']}, 07:44:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:44:07 INFO - 'tests': ['tsvgx', 07:44:07 INFO - 'tsvgr_opacity', 07:44:07 INFO - 'tart', 07:44:07 INFO - 'tscrollx', 07:44:07 INFO - 'cart']}, 07:44:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:44:07 INFO - 'tsvgr_opacity', 07:44:07 INFO - 'tart', 07:44:07 INFO - 'tscrollx', 07:44:07 INFO - 'cart']}, 07:44:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:07 INFO - 'talos_options': ['--disable-e10s'], 07:44:07 INFO - 'tests': ['tp5o']}, 07:44:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:07 INFO - 'tests': ['tp5o']}, 07:44:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:07 INFO - 'talos_options': ['--disable-e10s', 07:44:07 INFO - '--xperf_path', 07:44:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:07 INFO - 'tests': ['tp5n']}, 07:44:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:07 INFO - 'talos_options': ['--xperf_path', 07:44:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:07 INFO - 'tests': ['tp5n']}}, 07:44:07 INFO - 'talos.zip': {'path': '', 07:44:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:44:07 INFO - Running post-action listener: _resource_record_post_action 07:44:07 INFO - ##### 07:44:07 INFO - ##### Finished populate-webroot step (success) 07:44:07 INFO - ##### 07:44:07 INFO - ##### 07:44:07 INFO - ##### Running create-virtualenv step. 07:44:07 INFO - ##### 07:44:07 INFO - Running pre-action listener: _resource_record_pre_action 07:44:07 INFO - Running main action method: create_virtualenv 07:44:07 INFO - Creating virtualenv /builds/slave/test/build/venv 07:44:07 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 07:44:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:44:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:44:07 INFO - Using real prefix '/usr' 07:44:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:44:07 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:09 INFO - Installing pip.................done. 07:44:09 INFO - Return code: 0 07:44:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44:09 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')]} 07:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:09 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')]} 07:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:09 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 0x7f86dea6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', '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 07:44:09 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 07:44:09 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 07:44:09 INFO - Using env: {'DISPLAY': ':0', 07:44:09 INFO - 'HOME': '/home/cltbld', 07:44:09 INFO - 'LANG': 'en_US.UTF-8', 07:44:09 INFO - 'LANGUAGE': 'en_US:en', 07:44:09 INFO - 'LOGNAME': 'cltbld', 07:44:09 INFO - 'MAIL': '/var/mail/cltbld', 07:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:09 INFO - 'MOZ_NO_REMOTE': '1', 07:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:09 INFO - 'NO_EM_RESTART': '1', 07:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:09 INFO - 'PWD': '/builds/slave/test', 07:44:09 INFO - 'SHELL': '/bin/bash', 07:44:09 INFO - 'SHLVL': '1', 07:44:09 INFO - 'TERM': 'linux', 07:44:09 INFO - 'TMOUT': '86400', 07:44:09 INFO - 'USER': 'cltbld', 07:44:09 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:09 INFO - '_': '/tools/buildbot/bin/python'} 07:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:10 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 07:44:10 INFO - Cleaning up... 07:44:10 INFO - Return code: 0 07:44:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:10 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 0x7f86dea6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', '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 07:44:10 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 07:44:10 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 07:44:10 INFO - Using env: {'DISPLAY': ':0', 07:44:10 INFO - 'HOME': '/home/cltbld', 07:44:10 INFO - 'LANG': 'en_US.UTF-8', 07:44:10 INFO - 'LANGUAGE': 'en_US:en', 07:44:10 INFO - 'LOGNAME': 'cltbld', 07:44:10 INFO - 'MAIL': '/var/mail/cltbld', 07:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:10 INFO - 'MOZ_NO_REMOTE': '1', 07:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:10 INFO - 'NO_EM_RESTART': '1', 07:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:10 INFO - 'PWD': '/builds/slave/test', 07:44:10 INFO - 'SHELL': '/bin/bash', 07:44:10 INFO - 'SHLVL': '1', 07:44:10 INFO - 'TERM': 'linux', 07:44:10 INFO - 'TMOUT': '86400', 07:44:10 INFO - 'USER': 'cltbld', 07:44:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:10 INFO - '_': '/tools/buildbot/bin/python'} 07:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:10 INFO - Downloading/unpacking psutil>=3.1.1 07:44:10 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 07:44:10 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 07:44:10 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 07:44:10 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 07:44:10 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 07:44:10 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 07:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:12 INFO - Installing collected packages: psutil 07:44:12 INFO - Running setup.py install for psutil 07:44:12 INFO - building 'psutil._psutil_linux' extension 07:44:12 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 07:44:12 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 07:44:12 INFO - building 'psutil._psutil_posix' extension 07:44:12 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 07:44:12 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 07:44:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:12 INFO - Successfully installed psutil 07:44:12 INFO - Cleaning up... 07:44:12 INFO - Return code: 0 07:44:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:44:12 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')]} 07:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:12 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')]} 07:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:12 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 0x7f86dea6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', '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 07:44:12 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 07:44:12 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 07:44:12 INFO - Using env: {'DISPLAY': ':0', 07:44:12 INFO - 'HOME': '/home/cltbld', 07:44:12 INFO - 'LANG': 'en_US.UTF-8', 07:44:12 INFO - 'LANGUAGE': 'en_US:en', 07:44:12 INFO - 'LOGNAME': 'cltbld', 07:44:12 INFO - 'MAIL': '/var/mail/cltbld', 07:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:12 INFO - 'MOZ_NO_REMOTE': '1', 07:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:12 INFO - 'NO_EM_RESTART': '1', 07:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:12 INFO - 'PWD': '/builds/slave/test', 07:44:12 INFO - 'SHELL': '/bin/bash', 07:44:12 INFO - 'SHLVL': '1', 07:44:12 INFO - 'TERM': 'linux', 07:44:12 INFO - 'TMOUT': '86400', 07:44:12 INFO - 'USER': 'cltbld', 07:44:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:12 INFO - '_': '/tools/buildbot/bin/python'} 07:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:44:14 INFO - Installing collected packages: mozsystemmonitor 07:44:14 INFO - Running setup.py install for mozsystemmonitor 07:44:15 INFO - Successfully installed mozsystemmonitor 07:44:15 INFO - Cleaning up... 07:44:15 INFO - Return code: 0 07:44:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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', '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 0x7f86dea6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', '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 07:44: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:44: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 jsonschema==2.5.1 07:44:15 INFO - Using env: {'DISPLAY': ':0', 07:44:15 INFO - 'HOME': '/home/cltbld', 07:44:15 INFO - 'LANG': 'en_US.UTF-8', 07:44:15 INFO - 'LANGUAGE': 'en_US:en', 07:44:15 INFO - 'LOGNAME': 'cltbld', 07:44:15 INFO - 'MAIL': '/var/mail/cltbld', 07:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:15 INFO - 'MOZ_NO_REMOTE': '1', 07:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:15 INFO - 'NO_EM_RESTART': '1', 07:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:15 INFO - 'PWD': '/builds/slave/test', 07:44:15 INFO - 'SHELL': '/bin/bash', 07:44:15 INFO - 'SHLVL': '1', 07:44:15 INFO - 'TERM': 'linux', 07:44:15 INFO - 'TMOUT': '86400', 07:44:15 INFO - 'USER': 'cltbld', 07:44:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:15 INFO - '_': '/tools/buildbot/bin/python'} 07:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:15 INFO - Downloading/unpacking jsonschema==2.5.1 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:44:17 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 07:44:17 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 07:44:17 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 07:44:17 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 07:44:17 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 07:44:17 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 07:44:17 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:17 INFO - warning: no files found matching '*.txt' 07:44:17 INFO - no previously-included directories found matching 'build' 07:44:17 INFO - no previously-included directories found matching 'dist' 07:44:17 INFO - no previously-included directories found matching '.git*' 07:44:17 INFO - Installing collected packages: jsonschema, functools32 07:44:17 INFO - Running setup.py install for functools32 07:44:17 INFO - warning: no files found matching '*.txt' 07:44:17 INFO - no previously-included directories found matching 'build' 07:44:17 INFO - no previously-included directories found matching 'dist' 07:44:17 INFO - no previously-included directories found matching '.git*' 07:44:17 INFO - Successfully installed jsonschema functools32 07:44:17 INFO - Cleaning up... 07:44:17 INFO - Return code: 0 07:44:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f86dea6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', '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 07:44:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:44:17 INFO - Using env: {'DISPLAY': ':0', 07:44:17 INFO - 'HOME': '/home/cltbld', 07:44:17 INFO - 'LANG': 'en_US.UTF-8', 07:44:17 INFO - 'LANGUAGE': 'en_US:en', 07:44:17 INFO - 'LOGNAME': 'cltbld', 07:44:17 INFO - 'MAIL': '/var/mail/cltbld', 07:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:17 INFO - 'MOZ_NO_REMOTE': '1', 07:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:17 INFO - 'NO_EM_RESTART': '1', 07:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:17 INFO - 'PWD': '/builds/slave/test', 07:44:17 INFO - 'SHELL': '/bin/bash', 07:44:17 INFO - 'SHLVL': '1', 07:44:17 INFO - 'TERM': 'linux', 07:44:17 INFO - 'TMOUT': '86400', 07:44:17 INFO - 'USER': 'cltbld', 07:44:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:17 INFO - '_': '/tools/buildbot/bin/python'} 07:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:17 INFO - Downloading/unpacking blobuploader==1.2.4 07:44:17 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 07:44:17 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 07:44:17 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 07:44:17 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 07:44:17 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 07:44:17 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 07:44:19 INFO - Downloading blobuploader-1.2.4.tar.gz 07:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:44:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:44:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:20 INFO - Downloading docopt-0.6.1.tar.gz 07:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:44:20 INFO - Installing collected packages: blobuploader, requests, docopt 07:44:20 INFO - Running setup.py install for blobuploader 07:44:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:44:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:44:20 INFO - Running setup.py install for requests 07:44:21 INFO - Running setup.py install for docopt 07:44:21 INFO - Successfully installed blobuploader requests docopt 07:44:21 INFO - Cleaning up... 07:44:21 INFO - Return code: 0 07:44:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:21 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 0x7f86dea6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', '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 07:44:21 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 07:44:21 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 07:44:21 INFO - Using env: {'DISPLAY': ':0', 07:44:21 INFO - 'HOME': '/home/cltbld', 07:44:21 INFO - 'LANG': 'en_US.UTF-8', 07:44:21 INFO - 'LANGUAGE': 'en_US:en', 07:44:21 INFO - 'LOGNAME': 'cltbld', 07:44:21 INFO - 'MAIL': '/var/mail/cltbld', 07:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:21 INFO - 'MOZ_NO_REMOTE': '1', 07:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:21 INFO - 'NO_EM_RESTART': '1', 07:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:21 INFO - 'PWD': '/builds/slave/test', 07:44:21 INFO - 'SHELL': '/bin/bash', 07:44:21 INFO - 'SHLVL': '1', 07:44:21 INFO - 'TERM': 'linux', 07:44:21 INFO - 'TMOUT': '86400', 07:44:21 INFO - 'USER': 'cltbld', 07:44:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:21 INFO - '_': '/tools/buildbot/bin/python'} 07:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:21 INFO - Running setup.py (path:/tmp/pip-rk9CFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:21 INFO - Running setup.py (path:/tmp/pip-OwVBPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:21 INFO - Running setup.py (path:/tmp/pip-LCMD6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:21 INFO - Running setup.py (path:/tmp/pip-JQV5CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:21 INFO - Running setup.py (path:/tmp/pip-FGc0JD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:21 INFO - Running setup.py (path:/tmp/pip-UL3IGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:21 INFO - Running setup.py (path:/tmp/pip-7Cmzhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:21 INFO - Running setup.py (path:/tmp/pip-CEWfhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:22 INFO - Running setup.py (path:/tmp/pip-z70C9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:22 INFO - Running setup.py (path:/tmp/pip-dKy1kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:22 INFO - Running setup.py (path:/tmp/pip-m3IBn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:22 INFO - Running setup.py (path:/tmp/pip-KyDhFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:22 INFO - Running setup.py (path:/tmp/pip-0gmtD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:22 INFO - Running setup.py (path:/tmp/pip-0fN_14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:22 INFO - Running setup.py (path:/tmp/pip-9sAm5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:22 INFO - Running setup.py (path:/tmp/pip-WF3IYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:22 INFO - Running setup.py (path:/tmp/pip-BDbOIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:44:22 INFO - Running setup.py install for manifestparser 07:44:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:44:22 INFO - Running setup.py install for mozcrash 07:44:22 INFO - Running setup.py install for mozdebug 07:44:22 INFO - Running setup.py install for mozdevice 07:44:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Running setup.py install for mozfile 07:44:23 INFO - Running setup.py install for mozhttpd 07:44:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Running setup.py install for mozinfo 07:44:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Running setup.py install for mozInstall 07:44:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Running setup.py install for mozleak 07:44:23 INFO - Running setup.py install for mozlog 07:44:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Running setup.py install for moznetwork 07:44:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Running setup.py install for mozprocess 07:44:23 INFO - Running setup.py install for mozprofile 07:44:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:44:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:44:24 INFO - Running setup.py install for mozrunner 07:44:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:44:24 INFO - Running setup.py install for mozscreenshot 07:44:24 INFO - Running setup.py install for moztest 07:44:24 INFO - Running setup.py install for mozversion 07:44:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:44:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:44:24 INFO - Cleaning up... 07:44:24 INFO - Return code: 0 07:44:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:24 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')]} 07:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:24 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')]} 07:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:24 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 0x7f86dea6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', '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 07:44:24 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 07:44:24 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 07:44:24 INFO - Using env: {'DISPLAY': ':0', 07:44:24 INFO - 'HOME': '/home/cltbld', 07:44:24 INFO - 'LANG': 'en_US.UTF-8', 07:44:24 INFO - 'LANGUAGE': 'en_US:en', 07:44:24 INFO - 'LOGNAME': 'cltbld', 07:44:24 INFO - 'MAIL': '/var/mail/cltbld', 07:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:24 INFO - 'MOZ_NO_REMOTE': '1', 07:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:24 INFO - 'NO_EM_RESTART': '1', 07:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:24 INFO - 'PWD': '/builds/slave/test', 07:44:24 INFO - 'SHELL': '/bin/bash', 07:44:24 INFO - 'SHLVL': '1', 07:44:24 INFO - 'TERM': 'linux', 07:44:24 INFO - 'TMOUT': '86400', 07:44:24 INFO - 'USER': 'cltbld', 07:44:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:24 INFO - '_': '/tools/buildbot/bin/python'} 07:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:24 INFO - Running setup.py (path:/tmp/pip-As5g7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:24 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)) 07:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:24 INFO - Running setup.py (path:/tmp/pip-eQCI6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:24 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)) 07:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:24 INFO - Running setup.py (path:/tmp/pip-ReJ8GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:24 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)) 07:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:24 INFO - Running setup.py (path:/tmp/pip-Ti870U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:24 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)) 07:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:24 INFO - Running setup.py (path:/tmp/pip-kriEwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:25 INFO - Running setup.py (path:/tmp/pip-Cq4hKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:25 INFO - Running setup.py (path:/tmp/pip-78fmKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:25 INFO - Running setup.py (path:/tmp/pip-HZjoTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:25 INFO - Running setup.py (path:/tmp/pip-aRFMYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:25 INFO - Running setup.py (path:/tmp/pip-wHP4zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:25 INFO - Running setup.py (path:/tmp/pip-3KZoQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:25 INFO - Running setup.py (path:/tmp/pip-CGfWos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:25 INFO - Running setup.py (path:/tmp/pip-yXn17Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:25 INFO - Running setup.py (path:/tmp/pip-5AFbMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:25 INFO - Running setup.py (path:/tmp/pip-ZmKubJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:25 INFO - Running setup.py (path:/tmp/pip-ppyxbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:25 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)) 07:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:25 INFO - Running setup.py (path:/tmp/pip-j8THnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:25 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)) 07:44:25 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)) 07:44:25 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)) 07:44:25 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)) 07:44:25 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)) 07:44:25 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)) 07:44:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:44:25 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 07:44:25 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 07:44:25 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 07:44:25 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 07:44:25 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 07:44:25 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 07:44:27 INFO - Downloading blessings-1.6.tar.gz 07:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:44:27 INFO - Installing collected packages: blessings 07:44:27 INFO - Running setup.py install for blessings 07:44:27 INFO - Successfully installed blessings 07:44:27 INFO - Cleaning up... 07:44:28 INFO - Return code: 0 07:44:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:44:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:28 INFO - Reading from file tmpfile_stdout 07:44:28 INFO - Current package versions: 07:44:28 INFO - argparse == 1.2.1 07:44:28 INFO - blessings == 1.6 07:44:28 INFO - blobuploader == 1.2.4 07:44:28 INFO - docopt == 0.6.1 07:44:28 INFO - functools32 == 3.2.3-2 07:44:28 INFO - jsonschema == 2.5.1 07:44:28 INFO - manifestparser == 1.1 07:44:28 INFO - mozInstall == 1.12 07:44:28 INFO - mozcrash == 0.17 07:44:28 INFO - mozdebug == 0.1 07:44:28 INFO - mozdevice == 0.48 07:44:28 INFO - mozfile == 1.2 07:44:28 INFO - mozhttpd == 0.7 07:44:28 INFO - mozinfo == 0.9 07:44:28 INFO - mozleak == 0.1 07:44:28 INFO - mozlog == 3.2 07:44:28 INFO - moznetwork == 0.27 07:44:28 INFO - mozprocess == 0.22 07:44:28 INFO - mozprofile == 0.28 07:44:28 INFO - mozrunner == 6.11 07:44:28 INFO - mozscreenshot == 0.1 07:44:28 INFO - mozsystemmonitor == 0.3 07:44:28 INFO - moztest == 0.7 07:44:28 INFO - mozversion == 1.4 07:44:28 INFO - psutil == 3.1.1 07:44:28 INFO - requests == 1.2.3 07:44:28 INFO - wsgiref == 0.1.2 07:44:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:28 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 0x7f86dea6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', '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 07:44:28 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 07:44:28 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 07:44:28 INFO - Using env: {'DISPLAY': ':0', 07:44:28 INFO - 'HOME': '/home/cltbld', 07:44:28 INFO - 'LANG': 'en_US.UTF-8', 07:44:28 INFO - 'LANGUAGE': 'en_US:en', 07:44:28 INFO - 'LOGNAME': 'cltbld', 07:44:28 INFO - 'MAIL': '/var/mail/cltbld', 07:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:28 INFO - 'MOZ_NO_REMOTE': '1', 07:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:28 INFO - 'NO_EM_RESTART': '1', 07:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:28 INFO - 'PWD': '/builds/slave/test', 07:44:28 INFO - 'SHELL': '/bin/bash', 07:44:28 INFO - 'SHLVL': '1', 07:44:28 INFO - 'TERM': 'linux', 07:44:28 INFO - 'TMOUT': '86400', 07:44:28 INFO - 'USER': 'cltbld', 07:44:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:28 INFO - '_': '/tools/buildbot/bin/python'} 07:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:28 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)) 07:44:28 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)) 07:44:28 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)) 07:44:28 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)) 07:44:28 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)) 07:44:28 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)) 07:44:28 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)) 07:44:28 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)) 07:44:28 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)) 07:44:28 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)) 07:44:28 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)) 07:44:28 INFO - Cleaning up... 07:44:28 INFO - Return code: 0 07:44:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:28 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 0x7f86dea6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', '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 07:44:28 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 07:44:28 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 07:44:28 INFO - Using env: {'DISPLAY': ':0', 07:44:28 INFO - 'HOME': '/home/cltbld', 07:44:28 INFO - 'LANG': 'en_US.UTF-8', 07:44:28 INFO - 'LANGUAGE': 'en_US:en', 07:44:28 INFO - 'LOGNAME': 'cltbld', 07:44:28 INFO - 'MAIL': '/var/mail/cltbld', 07:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:28 INFO - 'MOZ_NO_REMOTE': '1', 07:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:28 INFO - 'NO_EM_RESTART': '1', 07:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:28 INFO - 'PWD': '/builds/slave/test', 07:44:28 INFO - 'SHELL': '/bin/bash', 07:44:28 INFO - 'SHLVL': '1', 07:44:28 INFO - 'TERM': 'linux', 07:44:28 INFO - 'TMOUT': '86400', 07:44:28 INFO - 'USER': 'cltbld', 07:44:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:28 INFO - '_': '/tools/buildbot/bin/python'} 07:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:44:28 INFO - Cleaning up... 07:44:28 INFO - Return code: 0 07:44:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:28 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 0x7f86dea6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', '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 07:44:28 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 07:44:28 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 07:44:28 INFO - Using env: {'DISPLAY': ':0', 07:44:28 INFO - 'HOME': '/home/cltbld', 07:44:28 INFO - 'LANG': 'en_US.UTF-8', 07:44:28 INFO - 'LANGUAGE': 'en_US:en', 07:44:28 INFO - 'LOGNAME': 'cltbld', 07:44:28 INFO - 'MAIL': '/var/mail/cltbld', 07:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:28 INFO - 'MOZ_NO_REMOTE': '1', 07:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:28 INFO - 'NO_EM_RESTART': '1', 07:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:28 INFO - 'PWD': '/builds/slave/test', 07:44:28 INFO - 'SHELL': '/bin/bash', 07:44:28 INFO - 'SHLVL': '1', 07:44:28 INFO - 'TERM': 'linux', 07:44:28 INFO - 'TMOUT': '86400', 07:44:28 INFO - 'USER': 'cltbld', 07:44:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:28 INFO - '_': '/tools/buildbot/bin/python'} 07:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:28 INFO - Downloading/unpacking flake8 07:44:28 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 07:44:28 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 07:44:28 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 07:44:28 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 07:44:28 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 07:44:28 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 07:44:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:44:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:44:30 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 07:44:30 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 07:44:30 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 07:44:30 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 07:44:30 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 07:44:30 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 07:44:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:44:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 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 07:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:44:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:31 INFO - no previously-included directories found matching 'docs/_build' 07:44:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:44:31 INFO - Running setup.py install for pep8 07:44:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:31 INFO - no previously-included directories found matching 'docs/_build' 07:44:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:44:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:44:31 INFO - Cleaning up... 07:44:31 INFO - Return code: 0 07:44:31 INFO - Running post-action listener: _resource_record_post_action 07:44:31 INFO - Running post-action listener: _start_resource_monitoring 07:44:31 INFO - Starting resource monitoring. 07:44:31 INFO - ##### 07:44:31 INFO - ##### Finished create-virtualenv step (success) 07:44:31 INFO - ##### 07:44:31 INFO - ##### 07:44:31 INFO - ##### Running install step. 07:44:31 INFO - ##### 07:44:31 INFO - Running pre-action listener: _resource_record_pre_action 07:44:31 INFO - Running main action method: install 07:44:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:32 INFO - Reading from file tmpfile_stdout 07:44:32 INFO - Detecting whether we're running mozinstall >=1.0... 07:44:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:44:32 INFO - Reading from file tmpfile_stdout 07:44:32 INFO - Output received: 07:44:32 INFO - Usage: mozinstall [options] installer 07:44:32 INFO - Options: 07:44:32 INFO - -h, --help show this help message and exit 07:44:32 INFO - -d DEST, --destination=DEST 07:44:32 INFO - Directory to install application into. [default: 07:44:32 INFO - "/builds/slave/test"] 07:44:32 INFO - --app=APP Application being installed. [default: firefox] 07:44:32 INFO - mkdir: /builds/slave/test/build/application 07:44:32 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'] 07:44:32 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 07:44:48 INFO - Reading from file tmpfile_stdout 07:44:48 INFO - Output received: 07:44:48 INFO - /builds/slave/test/build/application/firefox/firefox 07:44:48 INFO - Running post-action listener: _resource_record_post_action 07:44:48 INFO - ##### 07:44:48 INFO - ##### Finished install step (success) 07:44:48 INFO - ##### 07:44:48 INFO - ##### 07:44:48 INFO - ##### Running run-tests step. 07:44:48 INFO - ##### 07:44:48 INFO - Running pre-action listener: _resource_record_pre_action 07:44:48 INFO - Running main action method: run_tests 07:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:44:48 INFO - Python 2.7.3 07:44:48 INFO - Return code: 0 07:44:48 INFO - grabbing minidump binary from tooltool 07:44:48 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')]} 07:44:48 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 0x201e2e0>, '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 0x1f8a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:44:48 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 07:44:48 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 07:44:48 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 07:44:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:44:48 INFO - Return code: 0 07:44:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:44:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:44:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:44:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:44:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:44:49 INFO - Return code: 0 07:44:49 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/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 07:44:49 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/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 07:44:49 INFO - Using env: {'DISPLAY': ':0', 07:44:49 INFO - 'HOME': '/home/cltbld', 07:44:49 INFO - 'LANG': 'en_US.UTF-8', 07:44:49 INFO - 'LANGUAGE': 'en_US:en', 07:44:49 INFO - 'LOGNAME': 'cltbld', 07:44:49 INFO - 'MAIL': '/var/mail/cltbld', 07:44:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:44:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:49 INFO - 'MOZ_NO_REMOTE': '1', 07:44:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:49 INFO - 'NO_EM_RESTART': '1', 07:44:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:49 INFO - 'PWD': '/builds/slave/test', 07:44:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:44:49 INFO - 'SHELL': '/bin/bash', 07:44:49 INFO - 'SHLVL': '1', 07:44:49 INFO - 'TERM': 'linux', 07:44:49 INFO - 'TMOUT': '86400', 07:44:49 INFO - 'USER': 'cltbld', 07:44:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756', 07:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:49 INFO - '_': '/tools/buildbot/bin/python'} 07:44:49 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/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 07:44:49 INFO - mozversion application_buildid: 20160607062931 07:44:49 INFO - mozversion application_changeset: 7f7c7d24700eb80ce328b05fd260ec58e9725ca4 07:44:49 INFO - mozversion application_display_name: Nightly 07:44:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:44:49 INFO - mozversion application_name: Firefox 07:44:49 INFO - mozversion application_remotingname: firefox 07:44:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:44:49 INFO - mozversion application_vendor: Mozilla 07:44:49 INFO - mozversion application_version: 50.0a1 07:44:49 INFO - mozversion platform_buildid: 20160607062931 07:44:49 INFO - mozversion platform_changeset: 7f7c7d24700eb80ce328b05fd260ec58e9725ca4 07:44:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:44:49 INFO - mozversion platform_version: 50.0a1 07:44:49 INFO - using testdate: 1465310689 07:44:49 INFO - actual date: 1465310689 07:44:49 INFO - starting webserver on 'localhost:37036' 07:44:49 INFO - SUITE-START | Running 2 tests 07:44:49 INFO - TEST-START | dromaeo_css 07:44:49 INFO - operating with platform_type : linux_ 07:44:49 INFO - Initialising browser for dromaeo_css test... 07:44:49 INFO - TEST-INFO | started process 22948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc_joA5/profile http://localhost:37036/getInfo.html) 07:44:54 INFO - PROCESS | 22948 | __metrics Screen width/height:1600/1200 07:44:54 INFO - PROCESS | 22948 | colorDepth:24 07:44:54 INFO - PROCESS | 22948 | Browser inner width/height: 1024/697 07:44:54 INFO - PROCESS | 22948 | __metrics 07:44:54 ERROR - PROCESS | 22948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 07:44:55 INFO - TEST-INFO | 22948: exit 0 07:44:55 INFO - Browser initialized. 07:44:55 INFO - Running cycle 1/1 for dromaeo_css test... 07:44:55 INFO - TEST-INFO | started process 23067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc_joA5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:07 INFO - PROCESS | 23067 | RSS: Main: 168296448 07:45:07 INFO - PROCESS | 23067 | 07:45:57 INFO - PROCESS | 23067 | 1465310757502 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] 07:48:09 INFO - PROCESS | 23067 | Cycle 1(1): loaded http://localhost:37036/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37036/tests/dromaeo/cssquery-ext.html) 07:48:10 INFO - PROCESS | 23067 | RSS: Main: 171466752 07:48:10 INFO - PROCESS | 23067 | 07:51:12 INFO - PROCESS | 23067 | Cycle 1(1): loaded http://localhost:37036/tests/dromaeo/cssquery-ext.html (next: http://localhost:37036/tests/dromaeo/cssquery-jquery.html) 07:51:13 INFO - PROCESS | 23067 | RSS: Main: 169918464 07:51:13 INFO - PROCESS | 23067 | 07:54:15 INFO - PROCESS | 23067 | Cycle 1(1): loaded http://localhost:37036/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37036/tests/dromaeo/cssquery-mootools.html) 07:54:15 INFO - PROCESS | 23067 | RSS: Main: 170999808 07:54:15 INFO - PROCESS | 23067 | 07:57:17 INFO - PROCESS | 23067 | Cycle 1(1): loaded http://localhost:37036/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37036/tests/dromaeo/cssquery-prototype.html) 07:57:18 INFO - PROCESS | 23067 | RSS: Main: 168710144 07:57:18 INFO - PROCESS | 23067 | 08:00:21 INFO - PROCESS | 23067 | Cycle 1(1): loaded http://localhost:37036/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37036/tests/dromaeo/cssquery-yui.html) 08:00:21 INFO - PROCESS | 23067 | RSS: Main: 170127360 08:00:21 INFO - PROCESS | 23067 | 08:03:24 INFO - PROCESS | 23067 | Cycle 1(1): loaded http://localhost:37036/tests/dromaeo/cssquery-yui.html (next: http://localhost:37036/tests/dromaeo/cssquery-dojo.html) 08:03:24 INFO - PROCESS | 23067 | RSS: Main: 171491328 08:03:24 INFO - PROCESS | 23067 | 08:03:24 INFO - PROCESS | 23067 | __start_tp_report 08:03:24 INFO - PROCESS | 23067 | _x_x_mozilla_page_load 08:03:24 INFO - PROCESS | 23067 | _x_x_mozilla_page_load_details 08:03:24 INFO - PROCESS | 23067 | |i|pagename|runs| 08:03:24 INFO - PROCESS | 23067 | |0;dojo.html;2620.6069089636553;2676.250649818051;2685.6508653874994;2688.6370340004096;2688.9193324200282;4655.0224452864895;4658.208104622214;4658.371119898817;4779.80880764769;4825.78283977221;4603.987122832979;4646.465656449509;4713.269443236295;4754.9762251188695;4811;4354.499232588261;4421.867343979686;4421.88945276369;4434.091011342667;4438.97780511097;631.8541089851667;4319.222539942809;4320.913581728363;4327.242732521812;4385.6710746694125;4377.934330985054;4383;4396.120775844844;4416.227160246944;4442.2226110430865;4390.100029493946;4412;4427.579379958899;4429.402030725843;4446.844360447401;4365.039691267916;4400.339949007643;4431.40176076232;4440.023194897118;4464.196444639963;4727.314539391769;4751.64362672801;4761.857144285677;4766.761661916925;4768.237082066853;4898.044881248123;5132.153194722866;5143.665661731976;5151.124308867464;5203.661761985459;5183.714895680736;5209.244659524347;5221.477852214786;5234.659747116463;5284.709340986245;4831.782569784368;4869.9269510957365;4870.439899411542;4877.317175595419;4930.778114984834;5101.744912754348;5246.8425947220885;5294.100002999499;5330.2804121443105;5351.732413379315;5080.542751152414;5102.591792656579;5102.617303702237;5102.9489705103215;5144.151215049475;5132.307138536325;5182.611304152204;5186.536395212244;5194.97402512985;5206.140986737146;4887.584555312767;5067.189249720027;5079.2381142828135;5089.211172268304;5126.948730512647;5104.540591346797;5113.897722045538;5117.744112794346;5120.718360490135;5138.871528211825;4346.891327716769;4379.1460665170625;4379.802908869108;4381.605655491021;4397.6921615487245;3673.7061035117126;3700.7224458165747;3727.5713292971654;3733.533308336458;3782.2624588205035;4452.220861349251;4461.643068554507;4463.285874260103;4495.43807024122;4544.363789069533;5191.636585438983;5203.8178663746585;5210.53105220532;5228.215767634809;5247.370315562157;4292.291771857671;4440.178566965122;4474.463064432289;4498.8425405110665;4549.181147393435;4621.8613441596135;4658;4659.1147681941;4661.021185551004;4702.224133018082;4838.830640927551;4862.17343051675;4881.560659540658;4886.096072226649;4919.458859525521;4973.602111830973;5153.123968925217;5178.042062218502;5195.402528709247;5220.086484865209;4842.612590992641;4891.633127515522;4908.533689299511;4909.3372394727685;4960.330355401975;4806.711597304173;5130.999455106218;5134.332536770196;5142.8971420572125;5145.742712864417;5118.232265160255;5139.100657385017;5164.638475306692;5172.224166375074;5182.40402353719;5005.174146265826;5011.223260394645;5016.473270306566;5028.069807085701;5070.974645126898;4813.4945830688675;4934.136526107988;5000.224965130411;5011.649184557046;5013.674111182761;4883.291922671264;4887.926681099858;4958.404991401055;4967.9006419870675;4995.025969935828;5057.620678449204;5105.2342148678;5119.078565858182;5134;5182.481751824787;4960.677555958851;5004.649674522749;5009.5491405773655;5032.295478633067;5034.572061374678 08:03:24 INFO - PROCESS | 23067 | |1;ext.html;541.2385295895378;569.8603842058695;583.9970800146001;586.2261814404986;608.7656252342853;34642.65357346426;38958.805205973964;39066;39194;39279.60720392795;39354;39467.80266098673;40012;40097;40243.19513609726;7615.923840761577;7770.883436748425;7796.922030779676;7808.648610812527;7814.218578142169;7640.923590764105;7761.805954851117;7769.6892124315245;7789.571573563452;7800.921990780104;7747.922520774805;7756.495827771205;7812.140664526897;7815.413843961697;7840.4511684182135;7757.922420775804;7765.339946104559;7816.765497035098;7823.100343460518;7833.412494062968;7513.060867391576;7576.166621671667;7644.923550764533;7645.120811106738;7694.345980591601;29243.415131697246;36380.90857274286;37083.443748343794;37136.81431592852;37212.62787372119;2868.3402817352126;2910.767138628905;2958.2752225704626;3531.593866705336;3675.8713445029293;26742.866285668642;26777.59833602478;27081.45837083267;27571.586426203623;27707.722922770718;3402.6767457091537;3442.087846720621;3465.826708664582;3467.687908088284;3473.6179020307745;214288;214325;215512;215546;215612;31244.218894527363;31507;31512.89704860319;31556.842215788773;31576.842115789274;32773.50839737406;34406.13984650404;35072.01887839511;35239.82380088083;35440.46839297413;15127.697446051017;15179.468718595017;15251.542453726406;15254.161021143944;15301.693966120838;10119.392836429837;10180.185585153169;10219.489025548693;10245.538950747234;10286.537105830255;18299.817001830077;18317.81682183161;18328.725069123975;18350.449486515427;18357;7044.36600705939;7046.154461464657;7163.6060016699585;7224.988501609674;7340.596267205248;793.7141033822554;939.4504215034145;971.13568923658;995.3679413572434;1086.2776253791299;27526.862365688445;28256.43487130246;28256.85871570629;28307.433851322858;28322.85838570835;979;986.3342243985281;1046.2885238038207;1069.9411532365796;1101.6915263726169;14656.633584160481;14984.625384365478;15059.623509412353;15088.849111508964;15380;389525;392372;396360;397873;397879;48745.51254487481;49121.57905788496;49226.753866231156;49253;49306;1208.5890797129018;1219.3598360860442;1246.3830403949921;1247.731737676404;1261.6152073617452;26299.605505917043;27240.863795680896;27728.306792330353;27936.86031569829;28048.43903121885;41714.37428438515;41795;42148.367774482795;42304.365434517895;42425.5757442434;326383;328089;329700;330069;330640;24680.707599556223;24819.503609928062;25195;25244.62133068042;25377.111801086874;41646.58353416427;42308.57691423046;42682.78658606687;42716.00987930815;42716.932076697085;35822.28355432825;36041;36378.636213637525;36606.45090323594;36658.08354791151;35532.11169720778;36189.819050904574;36496.63503364933;36672.44991325079;37210;34099;36137;36421.45367819432;36559.81720091382;36667.63332366642;30991.69008309888;32115.678843212205;32365.352692945537;32721;32778;25150.371240719127;25373.746262537137;25448.637765806292;25732.356691082874;25798.484030319665 08:03:24 INFO - PROCESS | 23067 | |2;jquery.html;365.85000149938514;367.2618037744135;367.9981600091999;379.92781371539405;387.7305272835377;15476.535703928887;16572.751408728862;17468;17560.648787024253;17561.29754809806;16127.274272657729;16527.66944661106;17121.058341791195;17158;17234.655306893885;4931.506849315067;5174.275601415805;5200.583953283747;5217.58259339252;5222.712750798704;3667.8166091695443;5093.872653183663;5586.804461843836;5950.404959504058;5969.492593129589;5977.163197152402;5991.670458124801;6001.099835024737;6016.4885984691355;6027.758889644431;5828.912566311508;6026.246719160105;6053.636781793084;6066.090086487018;6069.544784141207;5111.744412779383;5289.814856480043;5294.655847369947;5307.469253074701;5325.920111198335;17910.731339029924;19006.144723487476;20412;20733.067011984498;20787.68818467724;1738.7143085021646;1789.91945362459;1831.423101722953;1896.3268039845932;1929.2379510093574;8732.912670873273;8907.331950103704;9215.078492150798;9376.203022743075;10749.731256718567;1773.2197832953589;1845.7785065792057;1874.2034635279952;1986.2650819196845;2029.6346657601625;67805.66097169483;69569;69685.65157174232;70061;71147;9712.854307185398;9865.704028879145;10008.39949603026;10084.294099412971;10233.339331773792;13762.24307663088;13819.792703109462;13868.098573592684;13870;13916.165030098024;7026.648667566704;7042.401395881305;7198.388137008413;7212.567245965259;7413.518121322097;6925.480588955848;6942.618156001468;6943.930560694429;7141.392981596518;7158.06945097134;4328.805203765838;4339;4340.609345158888;4406.427164468599;4441.955580444219;1716.9055701936513;1723.4743403262125;1840.8343249107645;1853.3791179954596;1868.3274021352302;753.5359374844338;832.2052439919862;840.6511297811462;906.1029580715176;939.5537119868007;16252.431164909407;16484.587885302964;16540.172991350624;16552.83447165537;16856.494305170865;841.2260720137489;853.4580541356283;881.6737807011447;887.4453466583385;896.2023798819056;9282.62869485213;9492.95253523728;9552.617895284111;9562.56968436422;9671.226301895831;376839;391094;394746;405488;405506;74759.62620186864;75149;75928.62035689897;76630;79193;918.8346097702344;922.7877588154628;923.4828496042238;943.9905600943903;946.1815529567012;14874.553763387115;14966.251687415368;15002.774958375852;15194;15298.770518442456;29600.111996640135;34184.82907585446;35607.82196089003;35761.82119089492;36664;46808.76595617;48734;48865;48956.51043489519;49551;7645.350145237717;7795.961020194863;7813.179616140451;7817.726379576688;7961.283484486424;10375.94812025935;11144.777104458028;11489.655310340702;11659.591914282959;12251.326177059991;10237.641682541076;10373.325733827278;10381.532831022772;10480.580776768844;10912.836307455553;10388.117010053928;10388.480575971322;10462.529186186792;10631.086404447275;10635.94682026585;10491.94754026225;10770.08454281395;10800.513976870903;10926.617568385069;10962.177836662442;7783.182765809508;7794.415418843496;7801.726939557088;7872.173421790859;7898.249666281694;10258.948705256425;10283.84574231402;10307.381557106597;10479.68560943173;10505.9474702626 08:03:24 INFO - PROCESS | 23067 | |3;mootools.html;1380.0822453068713;1411.4777532313044;1489.7467430536808;1688.198105899697;1701.8298170182975;6470.9029364559565;7332.046833911584;7387.482876198668;7885.408594355425;7911.802204944879;7415.740449084283;7429.21993190714;7497.47517673763;7497.737579184716;7500.39996800256;2128.5423633918704;2186.5517568898335;2190.288156349185;2190.6604476306197;2194.47332640166;2146.3239079689924;2153.5692861427697;2169.023939227346;2173.228503881115;2178.0960901226053;2129.190907455165;2139.3047259640603;2142.4001279641725;2149.6453085240914;2163.8485306028583;2095.0467537270583;2095.140992193201;2095.8637688550198;2098.391466474736;2107.062357251024;1961.6174845905055;1987.3044434447972;1997.850161237913;2062.5256191075987;2107.4099252209253;7458.813529661747;7499;7527.397808175333;7530.736424225181;7532.472726909118;4320.956790432087;4436.378906953029;4438.045820148651;4440.333949907507;4442.311441726538;2893.3056066544086;2944.852757362123;2979.478591246545;2983.1050684794477;2990.0880231529377;906.7869050773063;969.5249327829313;993.746594618375;1000.9499525023792;1007.1087087927164;10235.897641023568;10241.23190760696;10246.692599222035;10254.128399086087;10268.07587317145;4063.6342729154517;4101.91796164081;4208.494980602347;4212.30496968003;4214.789260536961;8872.73381798547;8882.86675699865;8896.777580560409;8929.642814287356;8931;4480.551944805494;4503.369528266046;4521.231390663529;4536.183486972377;4560.6807523473035;3553.2538166985223;4106.117184805281;4166.729162604421;4173.645240154621;4253.744775313491;3562.287542491512;3573.26748016656;3635.709143268532;3676.632336766302;3794.734368594227;1098.983515247272;1171.9355435450962;1181.0433548825479;1195.970100747471;1207.8852509011806;830.5224495914873;832.6169961817511;836.3518273338211;853.1894700034992;871.3813192633174;5000.549950504399;5203.947960520346;5237.214417837355;5391.838244852661;5435.83692489226;396.1285172620247;396.40143383491136;400.3734156045837;402.20965802198236;406.0478178671012;3573.446115852047;3578.8568457261417;3601.7478776485395;3656.2687462507606;3672.540932383452;9021.819563608691;9184.954075229582;9300.302477314093;9322.394044387229;9322.580483878242;9174.633014679472;9276.257899368034;9280.489573073412;9287.628494860264;9291.396059256262;7022.92977070233;7092.609906455092;7157.928420715831;7227.747028853965;7250.927490725026;5115.846524604268;5214.327422630965;5267.89464210706;5282.577393808563;5298.97350513245;8481.745547633582;8770.12298770118;8863.911360886308;8883.866741998745;8936.821263574562;8828.117188281121;8872.112788721077;8964.731058068268;9006.459612423276;9014.729558113268;6332.841678957879;7006.614636195059;7167.35150915282;7229.927700723136;7307.3058059484265;7351.044364232829;7360.77917662471;7380.77857664271;7383;7419.740309089156;6573.1783527059115;6643.734250630114;6713.362230588086;6809.114815074008;6942.409895158766;6369.9044514333245;6411.679416029273;6423.325550817097;6437.356264373525;6545.21457425112;5839.270091238595;5992.310884248367;5998.3401825798255;6007.429294217042;6045.848853778691;4364.127174565163;4516.16450956574;4549.65877559191;4559.680822342404;4573.131105090022;4507.030988337523;4532.0935812838225;4558.612517936012;4577.931331030104;4628.884277893079 08:03:24 INFO - PROCESS | 23067 | |4;prototype.html;296.9242843075017;299.3384619989822;299.4236095516131;307.6462068621086;311.7023242803123;4976;5011.674241174321;5012.849614511566;5057.570106540939;5094.344338090126;5001.224810154423;5004.624653151019;5010.348654674887;5020.523050310215;5031.446540880509;3736.8692095776655;3843.8078096095223;3947.842086316544;3959.594344007879;3964.7312859884846;3962.742421742592;3965.9801700991457;3967.1867267210155;3972.927309626399;3983.8406463741417;3929.76421414716;3935.60643935607;3944.7238693291483;3953;3991.6407523322896;3809.771413715186;3936.956706472787;3960.3663413853787;3964.9801750991205;3978.920421591552;3481.7813765182236;3489.45913383426;3503.2117773501013;3521.2781379817075;3527.153483164022;4702.153612349775;4751.382320298374;4777.832775852863;4785.803549112722;4788.11419887322;4461.219286624828;4532.614727748145;4536.818527258939;4552.6130278926;4557.430321209848;5208.801975545645;5218.973905130488;5246.56034943753;5258.13240815265;5259.947400525984;3823.8279277432584;3838.2707285615643;3845.403962385835;3848.5958974307855;3862.439946207784;5398.541124004425;5541.390447050821;5543.085390910495;5563.805266815642;5574.498295153415;3906.2187562487616;3917.804109794499;3933.272344616255;3934.9016274593364;3939.684825213976;3979.4428779970826;3994.1412596291357;3999.420084087791;4001.099752555652;4021.3364794809113;4498.515489888329;4516;4521.073179998092;4530.7119904448045;4552.772361381918;5176.559992400613;5230.986070362862;5293.311869456946;5312.92030619541;5362.544183744348;1366.8518444506662;1382.859141208507;1383.8201033865532;1386.6879952010718;1388.5070799865903;862.4566523090539;874.956252187388;880.4893161966045;884.730157302029;901.1304091551553;4518.728876267434;4648.1168577970075;4668.299755036772;4702;4720.622350211975;5462.945370546244;5467.418840659375;5471.917921231185;5507.146392309199;5527.668339899619;4423.911521769611;4629.65277604181;4705.8352957647;4723.220668589644;4729.148753224384;2854.5147324954805;2861.6136821529244;2886.292858249742;2891.2482754483985;2894.8697308621163;5073.822416215415;5097.209932460474;5106.191594622943;5110.182370820651;5117.744112794346;5385.838424847261;5441.483059109379;5500.917486237709;5529.806456773994;5546.334439867242;5063.468335824759;5065.240213967934;5070.492950704974;5073.1122053640465;5086.796528138833;5429.484199001088;5453;5461.371942226536;5461.972690136524;5463;5184.662996905189;5303.681779093266;5364.785408583613;5399.705125321644;5418.918716219338;5082.33929589151;5102.566281866083;5135.537801597874;5138.794448222179;5145.253938178868;3946.2304850555015;3946.960530394774;3963.3856752203455;3970.583088775637;3979.7015223857748;5279.841604751864;5394.732237924163;5397.78408863641;5423.186522021729;5464.590155738256;5196.402413722471;5251.816186433456;5256.868578285574;5260.736963151904;5291.550218231493;5210.759373469445;5230.424653288059;5252.185911183773;5258.237555554347;5266.183741520071;4884.975575122102;5101.591872650253;5146.408163061146;5164.147915593885;5166.870828229174;5054.974725126351;5105.923411148761;5223.869403264949;5274.868128296824;5277.683338999673;5139.460356662496;5174.094533456555;5178.249153872743;5208.453112423293;5212.166053431432 08:03:24 INFO - PROCESS | 23067 | |5;yui.html;675.1864003875328;706.452499313032;709.2411120101491;722.5123041946684;773.9226077392261;12386.071044671651;12951.158174718637;12985.961123110152;13023.153495022816;13038.869611303897;12817.295048772314;12930.159539629918;13003.219806811574;13005.804912926315;13053.738925221514;608.4007252855934;757.4508481351031;770.9845803083934;777.063638315828;789.1201310538737;776.4952780692538;785.654312102673;788.1566723605744;789.1043665439738;789.3448437796615;828.0766944856501;828.7513745876213;835.0105125426359;835.8620827563444;836.3184005035877;819.045811629451;823.6869989404048;824.2128767027474;824.9958750206271;828.4532208742231;612.0421540289433;615.2555407956378;615.7106160104788;616.1497133955158;616.4790751814754;11060;11172.553097876074;11232.719182020515;11251.60619378326;11290.20968532203;13223.801642975362;13585.252811095386;13594;13600.251986140758;13666.590002299947;10569.471526423726;10635.36187828725;10738.624148154777;10758.462076896123;10776.5689372425;3355.4295769719206;3381.070205693429;3386.6951974322183;3396.5924089109467;3404.489326601005;56379;56821.147682784795;56838;57654.7117264411;57979.42020579825;10162.745931351628;10349.172066234683;10351.171906247482;10561.735956600993;10780.353178809297;19837.900810496143;20273.69589456159;20281.594368112852;20323.491912702302;20330.898345508176;6651.66741662915;6678.766243181465;6734.6632668367365;6755.088063111417;6801.897971530431;3439.50127231555;3490.808005559719;3497.562804649419;3509.824508774551;3520.841562129659;2896.8551572421293;2979;2996.2209825445543;3019.9245018874262;3149.7322727567953;533.3652952985934;534.3240800387513;536.6243629459394;543.0306902179591;545.3483087710227;457.4464897474027;556.9805056823072;566.2779955556698;627.0656721485045;634.7334119669657;7578.696852125963;7715.922840771633;7720.227977202235;7761.301482866569;7978.361731061501;543.2801537962216;557.025205889693;560.1234068682498;590.7814108779779;596.6628854697083;3624.9275014499563;3744.4383342498845;3771.9622803771613;3825.8087095645105;3847.403652433877;59786.40213597808;59926.70036649789;60998.39001610016;72555.63722181461;103602;54388.72805635946;55020.44979550153;55386.44613553813;56885.715571421875;70721.64639176772;78245;79572.6021369901;80355.96440356034;80481.59759201166;80517.79223311655;7199;7309.8903516446235;7373.668184931798;7406.14829294638;7439.55362678241;36947.261054779294;36952.81523592365;45950.77024614855;47011.529884700714;48433.75783121062;53138.93722125613;58404.707976459846;60687;60794.69602651958;60795.69602152138;10853.186011049045;11015.559377624806;11085.944570277097;11507.42462876836;11660.533578657098;12082.516699331929;12151.39243037827;12620.17968832023;12728.872711272768;12840.55058072963;11930.642080737245;12034.458449369975;12129.21160124589;12242.632721018384;12683.048771342003;11634.53461861516;11645.59240426581;11821.290722556674;12247.142700010914;12453.501859925502;11747.353895535827;11896.702582435508;12121.939390302992;12187.817182742088;12464.813027804772;9468.95265523668;9653.613855445703;10198.847017294895;10455.790884182426;10665.520051597541;9490.240780737386;9535.284853635867;9554.474503902353;9565.234781217625;9654.56554455037 08:03:24 INFO - PROCESS | 23067 | __end_tp_report 08:03:24 INFO - PROCESS | 23067 | __start_cc_report 08:03:24 INFO - PROCESS | 23067 | _x_x_mozilla_cycle_collect,391 08:03:24 INFO - PROCESS | 23067 | __end_cc_report 08:03:24 INFO - PROCESS | 23067 | __startTimestamp1465311804739__endTimestamp 08:03:24 INFO - PROCESS | 23067 | 08:03:24 INFO - PROCESS | 23067 | ------- Summary: start ------- 08:03:24 INFO - PROCESS | 23067 | Number of tests: 6 08:03:24 INFO - PROCESS | 23067 | 08:03:24 INFO - PROCESS | 23067 | [#0] dojo.html Cycles:165 Average:4731.67 Median:4887.93 stddev:603.72 (12.4%) stddev-sans-first:582.42 08:03:24 INFO - PROCESS | 23067 | Values: 2620.6 2676.3 2685.7 2688.6 2688.9 4655.0 4658.2 4658.4 4779.8 4825.8 4604.0 4646.5 4713.3 4755.0 4811.0 4354.5 4421.9 4421.9 4434.1 4439.0 631.9 4319.2 4320.9 4327.2 4385.7 4377.9 4383.0 4396.1 4416.2 4442.2 4390.1 4412.0 4427.6 4429.4 4446.8 4365.0 4400.3 4431.4 4440.0 4464.2 4727.3 4751.6 4761.9 4766.8 4768.2 4898.0 5132.2 5143.7 5151.1 5203.7 5183.7 5209.2 5221.5 5234.7 5284.7 4831.8 4869.9 4870.4 4877.3 4930.8 5101.7 5246.8 5294.1 5330.3 5351.7 5080.5 5102.6 5102.6 5102.9 5144.2 5132.3 5182.6 5186.5 5195.0 5206.1 4887.6 5067.2 5079.2 5089.2 5126.9 5104.5 5113.9 5117.7 5120.7 5138.9 4346.9 4379.1 4379.8 4381.6 4397.7 3673.7 3700.7 3727.6 3733.5 3782.3 4452.2 4461.6 4463.3 4495.4 4544.4 5191.6 5203.8 5210.5 5228.2 5247.4 4292.3 4440.2 4474.5 4498.8 4549.2 4621.9 4658.0 4659.1 4661.0 4702.2 4838.8 4862.2 4881.6 4886.1 4919.5 4973.6 5153.1 5178.0 5195.4 5220.1 4842.6 4891.6 4908.5 4909.3 4960.3 4806.7 5131.0 5134.3 5142.9 5145.7 5118.2 5139.1 5164.6 5172.2 5182.4 5005.2 5011.2 5016.5 5028.1 5071.0 4813.5 4934.1 5000.2 5011.6 5013.7 4883.3 4887.9 4958.4 4967.9 4995.0 5057.6 5105.2 5119.1 5134.0 5182.5 4960.7 5004.6 5009.5 5032.3 5034.6 08:03:24 INFO - PROCESS | 23067 | 08:03:24 INFO - PROCESS | 23067 | [#1] ext.html Cycles:180 Average:45592.99 Median:35486.29 stddev:84863.50 (239.1%) stddev-sans-first:85034.15 08:03:24 INFO - PROCESS | 23067 | Values: 541.2 569.9 584.0 586.2 608.8 34642.7 38958.8 39066.0 39194.0 39279.6 39354.0 39467.8 40012.0 40097.0 40243.2 7615.9 7770.9 7796.9 7808.6 7814.2 7640.9 7761.8 7769.7 7789.6 7800.9 7747.9 7756.5 7812.1 7815.4 7840.5 7757.9 7765.3 7816.8 7823.1 7833.4 7513.1 7576.2 7644.9 7645.1 7694.3 29243.4 36380.9 37083.4 37136.8 37212.6 2868.3 2910.8 2958.3 3531.6 3675.9 26742.9 26777.6 27081.5 27571.6 27707.7 3402.7 3442.1 3465.8 3467.7 3473.6 214288.0 214325.0 215512.0 215546.0 215612.0 31244.2 31507.0 31512.9 31556.8 31576.8 32773.5 34406.1 35072.0 35239.8 35440.5 15127.7 15179.5 15251.5 15254.2 15301.7 10119.4 10180.2 10219.5 10245.5 10286.5 18299.8 18317.8 18328.7 18350.4 18357.0 7044.4 7046.2 7163.6 7225.0 7340.6 793.7 939.5 971.1 995.4 1086.3 27526.9 28256.4 28256.9 28307.4 28322.9 979.0 986.3 1046.3 1069.9 1101.7 14656.6 14984.6 15059.6 15088.8 15380.0 389525.0 392372.0 396360.0 397873.0 397879.0 48745.5 49121.6 49226.8 49253.0 49306.0 1208.6 1219.4 1246.4 1247.7 1261.6 26299.6 27240.9 27728.3 27936.9 28048.4 41714.4 41795.0 42148.4 42304.4 42425.6 326383.0 328089.0 329700.0 330069.0 330640.0 24680.7 24819.5 25195.0 25244.6 25377.1 41646.6 42308.6 42682.8 42716.0 42716.9 35822.3 36041.0 36378.6 36606.5 36658.1 35532.1 36189.8 36496.6 36672.4 37210.0 34099.0 36137.0 36421.5 36559.8 36667.6 30991.7 32115.7 32365.4 32721.0 32778.0 25150.4 25373.7 25448.6 25732.4 25798.5 08:03:24 INFO - PROCESS | 23067 | 08:03:24 INFO - PROCESS | 23067 | [#2] jquery.html Cycles:180 Average:24320.01 Median:4333.90 stddev:65113.55 (1502.4%) stddev-sans-first:65271.37 08:03:24 INFO - PROCESS | 23067 | Values: 365.9 367.3 368.0 379.9 387.7 15476.5 16572.8 17468.0 17560.6 17561.3 16127.3 16527.7 17121.1 17158.0 17234.7 4931.5 5174.3 5200.6 5217.6 5222.7 3667.8 5093.9 5586.8 5950.4 5969.5 5977.2 5991.7 6001.1 6016.5 6027.8 5828.9 6026.2 6053.6 6066.1 6069.5 5111.7 5289.8 5294.7 5307.5 5325.9 17910.7 19006.1 20412.0 20733.1 20787.7 1738.7 1789.9 1831.4 1896.3 1929.2 8732.9 8907.3 9215.1 9376.2 10749.7 1773.2 1845.8 1874.2 1986.3 2029.6 67805.7 69569.0 69685.7 70061.0 71147.0 9712.9 9865.7 10008.4 10084.3 10233.3 13762.2 13819.8 13868.1 13870.0 13916.2 7026.6 7042.4 7198.4 7212.6 7413.5 6925.5 6942.6 6943.9 7141.4 7158.1 4328.8 4339.0 4340.6 4406.4 4442.0 1716.9 1723.5 1840.8 1853.4 1868.3 753.5 832.2 840.7 906.1 939.6 16252.4 16484.6 16540.2 16552.8 16856.5 841.2 853.5 881.7 887.4 896.2 9282.6 9493.0 9552.6 9562.6 9671.2 376839.0 391094.0 394746.0 405488.0 405506.0 74759.6 75149.0 75928.6 76630.0 79193.0 918.8 922.8 923.5 944.0 946.2 14874.6 14966.3 15002.8 15194.0 15298.8 29600.1 34184.8 35607.8 35761.8 36664.0 46808.8 48734.0 48865.0 48956.5 49551.0 7645.4 7796.0 7813.2 7817.7 7961.3 10375.9 11144.8 11489.7 11659.6 12251.3 10237.6 10373.3 10381.5 10480.6 10912.8 10388.1 10388.5 10462.5 10631.1 10635.9 10491.9 10770.1 10800.5 10926.6 10962.2 7783.2 7794.4 7801.7 7872.2 7898.2 10258.9 10283.8 10307.4 10479.7 10505.9 08:03:24 INFO - PROCESS | 23067 | 08:03:24 INFO - PROCESS | 23067 | [#3] mootools.html Cycles:180 Average:5025.03 Median:4603.41 stddev:2802.39 (60.9%) stddev-sans-first:2796.86 08:03:24 INFO - PROCESS | 23067 | Values: 1380.1 1411.5 1489.7 1688.2 1701.8 6470.9 7332.0 7387.5 7885.4 7911.8 7415.7 7429.2 7497.5 7497.7 7500.4 2128.5 2186.6 2190.3 2190.7 2194.5 2146.3 2153.6 2169.0 2173.2 2178.1 2129.2 2139.3 2142.4 2149.6 2163.8 2095.0 2095.1 2095.9 2098.4 2107.1 1961.6 1987.3 1997.9 2062.5 2107.4 7458.8 7499.0 7527.4 7530.7 7532.5 4321.0 4436.4 4438.0 4440.3 4442.3 2893.3 2944.9 2979.5 2983.1 2990.1 906.8 969.5 993.7 1000.9 1007.1 10235.9 10241.2 10246.7 10254.1 10268.1 4063.6 4101.9 4208.5 4212.3 4214.8 8872.7 8882.9 8896.8 8929.6 8931.0 4480.6 4503.4 4521.2 4536.2 4560.7 3553.3 4106.1 4166.7 4173.6 4253.7 3562.3 3573.3 3635.7 3676.6 3794.7 1099.0 1171.9 1181.0 1196.0 1207.9 830.5 832.6 836.4 853.2 871.4 5000.5 5203.9 5237.2 5391.8 5435.8 396.1 396.4 400.4 402.2 406.0 3573.4 3578.9 3601.7 3656.3 3672.5 9021.8 9185.0 9300.3 9322.4 9322.6 9174.6 9276.3 9280.5 9287.6 9291.4 7022.9 7092.6 7157.9 7227.7 7250.9 5115.8 5214.3 5267.9 5282.6 5299.0 8481.7 8770.1 8863.9 8883.9 8936.8 8828.1 8872.1 8964.7 9006.5 9014.7 6332.8 7006.6 7167.4 7229.9 7307.3 7351.0 7360.8 7380.8 7383.0 7419.7 6573.2 6643.7 6713.4 6809.1 6942.4 6369.9 6411.7 6423.3 6437.4 6545.2 5839.3 5992.3 5998.3 6007.4 6045.8 4364.1 4516.2 4549.7 4559.7 4573.1 4507.0 4532.1 4558.6 4577.9 4628.9 08:03:24 INFO - PROCESS | 23067 | 08:03:24 INFO - PROCESS | 23067 | [#4] prototype.html Cycles:180 Average:4389.16 Median:5012.26 stddev:1261.29 (25.2%) stddev-sans-first:1226.86 08:03:24 INFO - PROCESS | 23067 | Values: 296.9 299.3 299.4 307.6 311.7 4976.0 5011.7 5012.8 5057.6 5094.3 5001.2 5004.6 5010.3 5020.5 5031.4 3736.9 3843.8 3947.8 3959.6 3964.7 3962.7 3966.0 3967.2 3972.9 3983.8 3929.8 3935.6 3944.7 3953.0 3991.6 3809.8 3937.0 3960.4 3965.0 3978.9 3481.8 3489.5 3503.2 3521.3 3527.2 4702.2 4751.4 4777.8 4785.8 4788.1 4461.2 4532.6 4536.8 4552.6 4557.4 5208.8 5219.0 5246.6 5258.1 5259.9 3823.8 3838.3 3845.4 3848.6 3862.4 5398.5 5541.4 5543.1 5563.8 5574.5 3906.2 3917.8 3933.3 3934.9 3939.7 3979.4 3994.1 3999.4 4001.1 4021.3 4498.5 4516.0 4521.1 4530.7 4552.8 5176.6 5231.0 5293.3 5312.9 5362.5 1366.9 1382.9 1383.8 1386.7 1388.5 862.5 875.0 880.5 884.7 901.1 4518.7 4648.1 4668.3 4702.0 4720.6 5462.9 5467.4 5471.9 5507.1 5527.7 4423.9 4629.7 4705.8 4723.2 4729.1 2854.5 2861.6 2886.3 2891.2 2894.9 5073.8 5097.2 5106.2 5110.2 5117.7 5385.8 5441.5 5500.9 5529.8 5546.3 5063.5 5065.2 5070.5 5073.1 5086.8 5429.5 5453.0 5461.4 5462.0 5463.0 5184.7 5303.7 5364.8 5399.7 5418.9 5082.3 5102.6 5135.5 5138.8 5145.3 3946.2 3947.0 3963.4 3970.6 3979.7 5279.8 5394.7 5397.8 5423.2 5464.6 5196.4 5251.8 5256.9 5260.7 5291.6 5210.8 5230.4 5252.2 5258.2 5266.2 4885.0 5101.6 5146.4 5164.1 5166.9 5055.0 5105.9 5223.9 5274.9 5277.7 5139.5 5174.1 5178.2 5208.5 5212.2 08:03:24 INFO - PROCESS | 23067 | 08:03:24 INFO - PROCESS | 23067 | [#5] yui.html Cycles:180 Average:16162.08 Median:26836.15 stddev:21669.54 (80.7%) stddev-sans-first:21699.13 08:03:24 INFO - PROCESS | 23067 | Values: 675.2 706.5 709.2 722.5 773.9 12386.1 12951.2 12986.0 13023.2 13038.9 12817.3 12930.2 13003.2 13005.8 13053.7 608.4 757.5 771.0 777.1 789.1 776.5 785.7 788.2 789.1 789.3 828.1 828.8 835.0 835.9 836.3 819.0 823.7 824.2 825.0 828.5 612.0 615.3 615.7 616.1 616.5 11060.0 11172.6 11232.7 11251.6 11290.2 13223.8 13585.3 13594.0 13600.3 13666.6 10569.5 10635.4 10738.6 10758.5 10776.6 3355.4 3381.1 3386.7 3396.6 3404.5 56379.0 56821.1 56838.0 57654.7 57979.4 10162.7 10349.2 10351.2 10561.7 10780.4 19837.9 20273.7 20281.6 20323.5 20330.9 6651.7 6678.8 6734.7 6755.1 6801.9 3439.5 3490.8 3497.6 3509.8 3520.8 2896.9 2979.0 2996.2 3019.9 3149.7 533.4 534.3 536.6 543.0 545.3 457.4 557.0 566.3 627.1 634.7 7578.7 7715.9 7720.2 7761.3 7978.4 543.3 557.0 560.1 590.8 596.7 3624.9 3744.4 3772.0 3825.8 3847.4 59786.4 59926.7 60998.4 72555.6 103602.0 54388.7 55020.4 55386.4 56885.7 70721.6 78245.0 79572.6 80356.0 80481.6 80517.8 7199.0 7309.9 7373.7 7406.1 7439.6 36947.3 36952.8 45950.8 47011.5 48433.8 53138.9 58404.7 60687.0 60794.7 60795.7 10853.2 11015.6 11085.9 11507.4 11660.5 12082.5 12151.4 12620.2 12728.9 12840.6 11930.6 12034.5 12129.2 12242.6 12683.0 11634.5 11645.6 11821.3 12247.1 12453.5 11747.4 11896.7 12121.9 12187.8 12464.8 9469.0 9653.6 10198.8 10455.8 10665.5 9490.2 9535.3 9554.5 9565.2 9654.6 08:03:24 INFO - PROCESS | 23067 | -------- Summary: end -------- 08:03:24 INFO - PROCESS | 23067 | 08:03:25 INFO - TEST-INFO | 23067: exit 0 08:03:25 INFO - TEST-OK | dromaeo_css | took 1116004ms 08:03:25 INFO - TEST-START | kraken 08:03:25 INFO - operating with platform_type : linux_ 08:03:25 INFO - Initialising browser for kraken test... 08:03:25 INFO - TEST-INFO | started process 23298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjnF_qw/profile http://localhost:37036/getInfo.html) 08:03:30 INFO - PROCESS | 23298 | __metrics Screen width/height:1600/1200 08:03:30 INFO - PROCESS | 23298 | colorDepth:24 08:03:30 INFO - PROCESS | 23298 | Browser inner width/height: 1024/697 08:03:30 INFO - PROCESS | 23298 | __metrics 08:03:30 ERROR - PROCESS | 23298 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 08:03:31 INFO - TEST-INFO | 23298: exit 0 08:03:31 INFO - Browser initialized. 08:03:31 INFO - Running cycle 1/1 for kraken test... 08:03:31 INFO - TEST-INFO | started process 23419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjnF_qw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:43 INFO - PROCESS | 23419 | RSS: Main: 168419328 08:03:43 INFO - PROCESS | 23419 | 08:03:46 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37036/tests/kraken/driver.html?testName=audio-beat-detection) 08:03:47 INFO - PROCESS | 23419 | RSS: Main: 173817856 08:03:47 INFO - PROCESS | 23419 | 08:03:50 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37036/tests/kraken/driver.html?testName=audio-dft) 08:03:50 INFO - PROCESS | 23419 | RSS: Main: 173248512 08:03:50 INFO - PROCESS | 23419 | 08:03:53 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37036/tests/kraken/driver.html?testName=audio-fft) 08:03:54 INFO - PROCESS | 23419 | RSS: Main: 167907328 08:03:54 INFO - PROCESS | 23419 | 08:03:56 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37036/tests/kraken/driver.html?testName=audio-oscillator) 08:03:57 INFO - PROCESS | 23419 | RSS: Main: 168247296 08:03:57 INFO - PROCESS | 23419 | 08:03:59 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37036/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:03:59 INFO - PROCESS | 23419 | RSS: Main: 168751104 08:03:59 INFO - PROCESS | 23419 | 08:04:03 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37036/tests/kraken/driver.html?testName=imaging-darkroom) 08:04:03 INFO - PROCESS | 23419 | RSS: Main: 168992768 08:04:03 INFO - PROCESS | 23419 | 08:04:07 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37036/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:07 INFO - PROCESS | 23419 | RSS: Main: 166854656 08:04:07 INFO - PROCESS | 23419 | 08:04:10 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37036/tests/kraken/driver.html?testName=json-parse-financial) 08:04:11 INFO - PROCESS | 23419 | RSS: Main: 167792640 08:04:11 INFO - PROCESS | 23419 | 08:04:13 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37036/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:04:13 INFO - PROCESS | 23419 | RSS: Main: 168779776 08:04:13 INFO - PROCESS | 23419 | 08:04:15 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37036/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:04:16 INFO - PROCESS | 23419 | RSS: Main: 169238528 08:04:16 INFO - PROCESS | 23419 | 08:04:18 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37036/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:04:19 INFO - PROCESS | 23419 | RSS: Main: 169496576 08:04:19 INFO - PROCESS | 23419 | 08:04:22 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37036/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:04:22 INFO - PROCESS | 23419 | RSS: Main: 169558016 08:04:22 INFO - PROCESS | 23419 | 08:04:25 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37036/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:04:26 INFO - PROCESS | 23419 | RSS: Main: 169381888 08:04:26 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | Cycle 1(1): loaded http://localhost:37036/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37036/tests/kraken/driver.html?testName=ai-astar) 08:04:28 INFO - PROCESS | 23419 | RSS: Main: 169975808 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | __start_tp_report 08:04:28 INFO - PROCESS | 23419 | _x_x_mozilla_page_load 08:04:28 INFO - PROCESS | 23419 | _x_x_mozilla_page_load_details 08:04:28 INFO - PROCESS | 23419 | |i|pagename|runs| 08:04:28 INFO - PROCESS | 23419 | |0;ai-astar;118;114;116;116;118;117;116;116;117;116 08:04:28 INFO - PROCESS | 23419 | |1;audio-beat-detection;158;130;160;196;142;155;162;138;189;131 08:04:28 INFO - PROCESS | 23419 | |2;audio-dft;164;164;164;174;165;165;162;163;162;161 08:04:28 INFO - PROCESS | 23419 | |3;audio-fft;76;76;78;173;77;78;76;76;156;77 08:04:28 INFO - PROCESS | 23419 | |4;audio-oscillator;87;86;153;87;87;86;144;86;86;142 08:04:28 INFO - PROCESS | 23419 | |5;imaging-gaussian-blur;118;117;118;118;117;117;118;117;117;118 08:04:28 INFO - PROCESS | 23419 | |6;imaging-darkroom;147;150;147;148;148;150;147;148;147;148 08:04:28 INFO - PROCESS | 23419 | |7;imaging-desaturate;96;96;96;96;95;96;95;96;96;96 08:04:28 INFO - PROCESS | 23419 | |8;json-parse-financial;64;63;63;64;64;65;63;64;63;68 08:04:28 INFO - PROCESS | 23419 | |9;json-stringify-tinderbox;64;64;65;66;66;66;65;65;65;65 08:04:28 INFO - PROCESS | 23419 | |10;stanford-crypto-aes;90;85;93;86;87;91;86;87;111;85 08:04:28 INFO - PROCESS | 23419 | |11;stanford-crypto-ccm;143;136;131;140;143;141;149;142;148;149 08:04:28 INFO - PROCESS | 23419 | |12;stanford-crypto-pbkdf2;170;172;170;168;169;170;169;172;169;168 08:04:28 INFO - PROCESS | 23419 | |13;stanford-crypto-sha256-iterative;74;67;68;69;72;71;69;67;68;68 08:04:28 INFO - PROCESS | 23419 | __end_tp_report 08:04:28 INFO - PROCESS | 23419 | __start_cc_report 08:04:28 INFO - PROCESS | 23419 | _x_x_mozilla_cycle_collect,975 08:04:28 INFO - PROCESS | 23419 | __end_cc_report 08:04:28 INFO - PROCESS | 23419 | __startTimestamp1465311868364__endTimestamp 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | ------- Summary: start ------- 08:04:28 INFO - PROCESS | 23419 | Number of tests: 14 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.50 stddev:1.17 (1.0%) stddev-sans-first:1.09 08:04:28 INFO - PROCESS | 23419 | Values: 118.0 114.0 116.0 116.0 118.0 117.0 116.0 116.0 117.0 116.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:159.00 stddev:22.53 (14.2%) stddev-sans-first:23.88 08:04:28 INFO - PROCESS | 23419 | Values: 158.0 130.0 160.0 196.0 142.0 155.0 162.0 138.0 189.0 131.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.63 (2.2%) stddev-sans-first:3.84 08:04:28 INFO - PROCESS | 23419 | Values: 164.0 164.0 164.0 174.0 165.0 165.0 162.0 163.0 162.0 161.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.50 stddev:37.22 (48.7%) stddev-sans-first:38.89 08:04:28 INFO - PROCESS | 23419 | Values: 76.0 76.0 78.0 173.0 77.0 78.0 76.0 76.0 156.0 77.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:86.00 stddev:29.07 (33.8%) stddev-sans-first:30.15 08:04:28 INFO - PROCESS | 23419 | Values: 87.0 86.0 153.0 87.0 87.0 86.0 144.0 86.0 86.0 142.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:04:28 INFO - PROCESS | 23419 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 118.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.15 (0.8%) stddev-sans-first:1.17 08:04:28 INFO - PROCESS | 23419 | Values: 147.0 150.0 147.0 148.0 148.0 150.0 147.0 148.0 147.0 148.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:04:28 INFO - PROCESS | 23419 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:1.52 (2.4%) stddev-sans-first:1.62 08:04:28 INFO - PROCESS | 23419 | Values: 64.0 63.0 63.0 64.0 64.0 65.0 63.0 64.0 63.0 68.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 08:04:28 INFO - PROCESS | 23419 | Values: 64.0 64.0 65.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:87.00 stddev:7.82 (9.0%) stddev-sans-first:8.30 08:04:28 INFO - PROCESS | 23419 | Values: 90.0 85.0 93.0 86.0 87.0 91.0 86.0 87.0 111.0 85.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:143.00 stddev:5.75 (4.0%) stddev-sans-first:6.09 08:04:28 INFO - PROCESS | 23419 | Values: 143.0 136.0 131.0 140.0 143.0 141.0 149.0 142.0 148.0 149.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.00 stddev:1.42 (0.8%) stddev-sans-first:1.50 08:04:28 INFO - PROCESS | 23419 | Values: 170.0 172.0 170.0 168.0 169.0 170.0 169.0 172.0 169.0 168.0 08:04:28 INFO - PROCESS | 23419 | 08:04:28 INFO - PROCESS | 23419 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.31 (3.4%) stddev-sans-first:1.72 08:04:28 INFO - PROCESS | 23419 | Values: 74.0 67.0 68.0 69.0 72.0 71.0 69.0 67.0 68.0 68.0 08:04:28 INFO - PROCESS | 23419 | -------- Summary: end -------- 08:04:28 INFO - PROCESS | 23419 | 08:04:29 INFO - TEST-INFO | 23419: exit 0 08:04:29 INFO - TEST-OK | kraken | took 63973ms 08:04:29 INFO - SUITE-END | took 1179s 08:04:29 INFO - Completed test suite (00:19:40) 08:04:29 INFO - javascript benchmark 08:04:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6374.0938316471775, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.6069089636553, 2676.250649818051, 2685.6508653874994, 2688.6370340004096, 2688.9193324200282, 4655.0224452864895, 4658.208104622214, 4658.371119898817, 4779.80880764769, 4825.78283977221, 4603.987122832979, 4646.465656449509, 4713.269443236295, 4754.9762251188695, 4811.0, 4354.499232588261, 4421.867343979686, 4421.88945276369, 4434.091011342667, 4438.97780511097, 631.8541089851667, 4319.222539942809, 4320.913581728363, 4327.242732521812, 4385.6710746694125, 4377.934330985054, 4383.0, 4396.120775844844, 4416.227160246944, 4442.2226110430865, 4390.100029493946, 4412.0, 4427.579379958899, 4429.402030725843, 4446.844360447401, 4365.039691267916, 4400.339949007643, 4431.40176076232, 4440.023194897118, 4464.196444639963, 4727.314539391769, 4751.64362672801, 4761.857144285677, 4766.761661916925, 4768.237082066853, 4898.044881248123, 5132.153194722866, 5143.665661731976, 5151.124308867464, 5203.661761985459, 5183.714895680736, 5209.244659524347, 5221.477852214786, 5234.659747116463, 5284.709340986245, 4831.782569784368, 4869.9269510957365, 4870.439899411542, 4877.317175595419, 4930.778114984834, 5101.744912754348, 5246.8425947220885, 5294.100002999499, 5330.2804121443105, 5351.732413379315, 5080.542751152414, 5102.591792656579, 5102.617303702237, 5102.9489705103215, 5144.151215049475, 5132.307138536325, 5182.611304152204, 5186.536395212244, 5194.97402512985, 5206.140986737146, 4887.584555312767, 5067.189249720027, 5079.2381142828135, 5089.211172268304, 5126.948730512647, 5104.540591346797, 5113.897722045538, 5117.744112794346, 5120.718360490135, 5138.871528211825, 4346.891327716769, 4379.1460665170625, 4379.802908869108, 4381.605655491021, 4397.6921615487245, 3673.7061035117126, 3700.7224458165747, 3727.5713292971654, 3733.533308336458, 3782.2624588205035, 4452.220861349251, 4461.643068554507, 4463.285874260103, 4495.43807024122, 4544.363789069533, 5191.636585438983, 5203.8178663746585, 5210.53105220532, 5228.215767634809, 5247.370315562157, 4292.291771857671, 4440.178566965122, 4474.463064432289, 4498.8425405110665, 4549.181147393435, 4621.8613441596135, 4658.0, 4659.1147681941, 4661.021185551004, 4702.224133018082, 4838.830640927551, 4862.17343051675, 4881.560659540658, 4886.096072226649, 4919.458859525521, 4973.602111830973, 5153.123968925217, 5178.042062218502, 5195.402528709247, 5220.086484865209, 4842.612590992641, 4891.633127515522, 4908.533689299511, 4909.3372394727685, 4960.330355401975, 4806.711597304173, 5130.999455106218, 5134.332536770196, 5142.8971420572125, 5145.742712864417, 5118.232265160255, 5139.100657385017, 5164.638475306692, 5172.224166375074, 5182.40402353719, 5005.174146265826, 5011.223260394645, 5016.473270306566, 5028.069807085701, 5070.974645126898, 4813.4945830688675, 4934.136526107988, 5000.224965130411, 5011.649184557046, 5013.674111182761, 4883.291922671264, 4887.926681099858, 4958.404991401055, 4967.9006419870675, 4995.025969935828, 5057.620678449204, 5105.2342148678, 5119.078565858182, 5134.0, 5182.481751824787, 4960.677555958851, 5004.649674522749, 5009.5491405773655, 5032.295478633067, 5034.572061374678], "value": 4693.912765425901, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.2385295895378, 569.8603842058695, 583.9970800146001, 586.2261814404986, 608.7656252342853, 34642.65357346426, 38958.805205973964, 39066.0, 39194.0, 39279.60720392795, 39354.0, 39467.80266098673, 40012.0, 40097.0, 40243.19513609726, 7615.923840761577, 7770.883436748425, 7796.922030779676, 7808.648610812527, 7814.218578142169, 7640.923590764105, 7761.805954851117, 7769.6892124315245, 7789.571573563452, 7800.921990780104, 7747.922520774805, 7756.495827771205, 7812.140664526897, 7815.413843961697, 7840.4511684182135, 7757.922420775804, 7765.339946104559, 7816.765497035098, 7823.100343460518, 7833.412494062968, 7513.060867391576, 7576.166621671667, 7644.923550764533, 7645.120811106738, 7694.345980591601, 29243.415131697246, 36380.90857274286, 37083.443748343794, 37136.81431592852, 37212.62787372119, 2868.3402817352126, 2910.767138628905, 2958.2752225704626, 3531.593866705336, 3675.8713445029293, 26742.866285668642, 26777.59833602478, 27081.45837083267, 27571.586426203623, 27707.722922770718, 3402.6767457091537, 3442.087846720621, 3465.826708664582, 3467.687908088284, 3473.6179020307745, 214288.0, 214325.0, 215512.0, 215546.0, 215612.0, 31244.218894527363, 31507.0, 31512.89704860319, 31556.842215788773, 31576.842115789274, 32773.50839737406, 34406.13984650404, 35072.01887839511, 35239.82380088083, 35440.46839297413, 15127.697446051017, 15179.468718595017, 15251.542453726406, 15254.161021143944, 15301.693966120838, 10119.392836429837, 10180.185585153169, 10219.489025548693, 10245.538950747234, 10286.537105830255, 18299.817001830077, 18317.81682183161, 18328.725069123975, 18350.449486515427, 18357.0, 7044.36600705939, 7046.154461464657, 7163.6060016699585, 7224.988501609674, 7340.596267205248, 793.7141033822554, 939.4504215034145, 971.13568923658, 995.3679413572434, 1086.2776253791299, 27526.862365688445, 28256.43487130246, 28256.85871570629, 28307.433851322858, 28322.85838570835, 979.0, 986.3342243985281, 1046.2885238038207, 1069.9411532365796, 1101.6915263726169, 14656.633584160481, 14984.625384365478, 15059.623509412353, 15088.849111508964, 15380.0, 389525.0, 392372.0, 396360.0, 397873.0, 397879.0, 48745.51254487481, 49121.57905788496, 49226.753866231156, 49253.0, 49306.0, 1208.5890797129018, 1219.3598360860442, 1246.3830403949921, 1247.731737676404, 1261.6152073617452, 26299.605505917043, 27240.863795680896, 27728.306792330353, 27936.86031569829, 28048.43903121885, 41714.37428438515, 41795.0, 42148.367774482795, 42304.365434517895, 42425.5757442434, 326383.0, 328089.0, 329700.0, 330069.0, 330640.0, 24680.707599556223, 24819.503609928062, 25195.0, 25244.62133068042, 25377.111801086874, 41646.58353416427, 42308.57691423046, 42682.78658606687, 42716.00987930815, 42716.932076697085, 35822.28355432825, 36041.0, 36378.636213637525, 36606.45090323594, 36658.08354791151, 35532.11169720778, 36189.819050904574, 36496.63503364933, 36672.44991325079, 37210.0, 34099.0, 36137.0, 36421.45367819432, 36559.81720091382, 36667.63332366642, 30991.69008309888, 32115.678843212205, 32365.352692945537, 32721.0, 32778.0, 25150.371240719127, 25373.746262537137, 25448.637765806292, 25732.356691082874, 25798.484030319665], "value": 17000.436845679746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.85000149938514, 367.2618037744135, 367.9981600091999, 379.92781371539405, 387.7305272835377, 15476.535703928887, 16572.751408728862, 17468.0, 17560.648787024253, 17561.29754809806, 16127.274272657729, 16527.66944661106, 17121.058341791195, 17158.0, 17234.655306893885, 4931.506849315067, 5174.275601415805, 5200.583953283747, 5217.58259339252, 5222.712750798704, 3667.8166091695443, 5093.872653183663, 5586.804461843836, 5950.404959504058, 5969.492593129589, 5977.163197152402, 5991.670458124801, 6001.099835024737, 6016.4885984691355, 6027.758889644431, 5828.912566311508, 6026.246719160105, 6053.636781793084, 6066.090086487018, 6069.544784141207, 5111.744412779383, 5289.814856480043, 5294.655847369947, 5307.469253074701, 5325.920111198335, 17910.731339029924, 19006.144723487476, 20412.0, 20733.067011984498, 20787.68818467724, 1738.7143085021646, 1789.91945362459, 1831.423101722953, 1896.3268039845932, 1929.2379510093574, 8732.912670873273, 8907.331950103704, 9215.078492150798, 9376.203022743075, 10749.731256718567, 1773.2197832953589, 1845.7785065792057, 1874.2034635279952, 1986.2650819196845, 2029.6346657601625, 67805.66097169483, 69569.0, 69685.65157174232, 70061.0, 71147.0, 9712.854307185398, 9865.704028879145, 10008.39949603026, 10084.294099412971, 10233.339331773792, 13762.24307663088, 13819.792703109462, 13868.098573592684, 13870.0, 13916.165030098024, 7026.648667566704, 7042.401395881305, 7198.388137008413, 7212.567245965259, 7413.518121322097, 6925.480588955848, 6942.618156001468, 6943.930560694429, 7141.392981596518, 7158.06945097134, 4328.805203765838, 4339.0, 4340.609345158888, 4406.427164468599, 4441.955580444219, 1716.9055701936513, 1723.4743403262125, 1840.8343249107645, 1853.3791179954596, 1868.3274021352302, 753.5359374844338, 832.2052439919862, 840.6511297811462, 906.1029580715176, 939.5537119868007, 16252.431164909407, 16484.587885302964, 16540.172991350624, 16552.83447165537, 16856.494305170865, 841.2260720137489, 853.4580541356283, 881.6737807011447, 887.4453466583385, 896.2023798819056, 9282.62869485213, 9492.95253523728, 9552.617895284111, 9562.56968436422, 9671.226301895831, 376839.0, 391094.0, 394746.0, 405488.0, 405506.0, 74759.62620186864, 75149.0, 75928.62035689897, 76630.0, 79193.0, 918.8346097702344, 922.7877588154628, 923.4828496042238, 943.9905600943903, 946.1815529567012, 14874.553763387115, 14966.251687415368, 15002.774958375852, 15194.0, 15298.770518442456, 29600.111996640135, 34184.82907585446, 35607.82196089003, 35761.82119089492, 36664.0, 46808.76595617, 48734.0, 48865.0, 48956.51043489519, 49551.0, 7645.350145237717, 7795.961020194863, 7813.179616140451, 7817.726379576688, 7961.283484486424, 10375.94812025935, 11144.777104458028, 11489.655310340702, 11659.591914282959, 12251.326177059991, 10237.641682541076, 10373.325733827278, 10381.532831022772, 10480.580776768844, 10912.836307455553, 10388.117010053928, 10388.480575971322, 10462.529186186792, 10631.086404447275, 10635.94682026585, 10491.94754026225, 10770.08454281395, 10800.513976870903, 10926.617568385069, 10962.177836662442, 7783.182765809508, 7794.415418843496, 7801.726939557088, 7872.173421790859, 7898.249666281694, 10258.948705256425, 10283.84574231402, 10307.381557106597, 10479.68560943173, 10505.9474702626], "value": 8246.371155832318, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.0822453068713, 1411.4777532313044, 1489.7467430536808, 1688.198105899697, 1701.8298170182975, 6470.9029364559565, 7332.046833911584, 7387.482876198668, 7885.408594355425, 7911.802204944879, 7415.740449084283, 7429.21993190714, 7497.47517673763, 7497.737579184716, 7500.39996800256, 2128.5423633918704, 2186.5517568898335, 2190.288156349185, 2190.6604476306197, 2194.47332640166, 2146.3239079689924, 2153.5692861427697, 2169.023939227346, 2173.228503881115, 2178.0960901226053, 2129.190907455165, 2139.3047259640603, 2142.4001279641725, 2149.6453085240914, 2163.8485306028583, 2095.0467537270583, 2095.140992193201, 2095.8637688550198, 2098.391466474736, 2107.062357251024, 1961.6174845905055, 1987.3044434447972, 1997.850161237913, 2062.5256191075987, 2107.4099252209253, 7458.813529661747, 7499.0, 7527.397808175333, 7530.736424225181, 7532.472726909118, 4320.956790432087, 4436.378906953029, 4438.045820148651, 4440.333949907507, 4442.311441726538, 2893.3056066544086, 2944.852757362123, 2979.478591246545, 2983.1050684794477, 2990.0880231529377, 906.7869050773063, 969.5249327829313, 993.746594618375, 1000.9499525023792, 1007.1087087927164, 10235.897641023568, 10241.23190760696, 10246.692599222035, 10254.128399086087, 10268.07587317145, 4063.6342729154517, 4101.91796164081, 4208.494980602347, 4212.30496968003, 4214.789260536961, 8872.73381798547, 8882.86675699865, 8896.777580560409, 8929.642814287356, 8931.0, 4480.551944805494, 4503.369528266046, 4521.231390663529, 4536.183486972377, 4560.6807523473035, 3553.2538166985223, 4106.117184805281, 4166.729162604421, 4173.645240154621, 4253.744775313491, 3562.287542491512, 3573.26748016656, 3635.709143268532, 3676.632336766302, 3794.734368594227, 1098.983515247272, 1171.9355435450962, 1181.0433548825479, 1195.970100747471, 1207.8852509011806, 830.5224495914873, 832.6169961817511, 836.3518273338211, 853.1894700034992, 871.3813192633174, 5000.549950504399, 5203.947960520346, 5237.214417837355, 5391.838244852661, 5435.83692489226, 396.1285172620247, 396.40143383491136, 400.3734156045837, 402.20965802198236, 406.0478178671012, 3573.446115852047, 3578.8568457261417, 3601.7478776485395, 3656.2687462507606, 3672.540932383452, 9021.819563608691, 9184.954075229582, 9300.302477314093, 9322.394044387229, 9322.580483878242, 9174.633014679472, 9276.257899368034, 9280.489573073412, 9287.628494860264, 9291.396059256262, 7022.92977070233, 7092.609906455092, 7157.928420715831, 7227.747028853965, 7250.927490725026, 5115.846524604268, 5214.327422630965, 5267.89464210706, 5282.577393808563, 5298.97350513245, 8481.745547633582, 8770.12298770118, 8863.911360886308, 8883.866741998745, 8936.821263574562, 8828.117188281121, 8872.112788721077, 8964.731058068268, 9006.459612423276, 9014.729558113268, 6332.841678957879, 7006.614636195059, 7167.35150915282, 7229.927700723136, 7307.3058059484265, 7351.044364232829, 7360.77917662471, 7380.77857664271, 7383.0, 7419.740309089156, 6573.1783527059115, 6643.734250630114, 6713.362230588086, 6809.114815074008, 6942.409895158766, 6369.9044514333245, 6411.679416029273, 6423.325550817097, 6437.356264373525, 6545.21457425112, 5839.270091238595, 5992.310884248367, 5998.3401825798255, 6007.429294217042, 6045.848853778691, 4364.127174565163, 4516.16450956574, 4549.65877559191, 4559.680822342404, 4573.131105090022, 4507.030988337523, 4532.0935812838225, 4558.612517936012, 4577.931331030104, 4628.884277893079], "value": 3997.721276507009, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.9242843075017, 299.3384619989822, 299.4236095516131, 307.6462068621086, 311.7023242803123, 4976.0, 5011.674241174321, 5012.849614511566, 5057.570106540939, 5094.344338090126, 5001.224810154423, 5004.624653151019, 5010.348654674887, 5020.523050310215, 5031.446540880509, 3736.8692095776655, 3843.8078096095223, 3947.842086316544, 3959.594344007879, 3964.7312859884846, 3962.742421742592, 3965.9801700991457, 3967.1867267210155, 3972.927309626399, 3983.8406463741417, 3929.76421414716, 3935.60643935607, 3944.7238693291483, 3953.0, 3991.6407523322896, 3809.771413715186, 3936.956706472787, 3960.3663413853787, 3964.9801750991205, 3978.920421591552, 3481.7813765182236, 3489.45913383426, 3503.2117773501013, 3521.2781379817075, 3527.153483164022, 4702.153612349775, 4751.382320298374, 4777.832775852863, 4785.803549112722, 4788.11419887322, 4461.219286624828, 4532.614727748145, 4536.818527258939, 4552.6130278926, 4557.430321209848, 5208.801975545645, 5218.973905130488, 5246.56034943753, 5258.13240815265, 5259.947400525984, 3823.8279277432584, 3838.2707285615643, 3845.403962385835, 3848.5958974307855, 3862.439946207784, 5398.541124004425, 5541.390447050821, 5543.085390910495, 5563.805266815642, 5574.498295153415, 3906.2187562487616, 3917.804109794499, 3933.272344616255, 3934.9016274593364, 3939.684825213976, 3979.4428779970826, 3994.1412596291357, 3999.420084087791, 4001.099752555652, 4021.3364794809113, 4498.515489888329, 4516.0, 4521.073179998092, 4530.7119904448045, 4552.772361381918, 5176.559992400613, 5230.986070362862, 5293.311869456946, 5312.92030619541, 5362.544183744348, 1366.8518444506662, 1382.859141208507, 1383.8201033865532, 1386.6879952010718, 1388.5070799865903, 862.4566523090539, 874.956252187388, 880.4893161966045, 884.730157302029, 901.1304091551553, 4518.728876267434, 4648.1168577970075, 4668.299755036772, 4702.0, 4720.622350211975, 5462.945370546244, 5467.418840659375, 5471.917921231185, 5507.146392309199, 5527.668339899619, 4423.911521769611, 4629.65277604181, 4705.8352957647, 4723.220668589644, 4729.148753224384, 2854.5147324954805, 2861.6136821529244, 2886.292858249742, 2891.2482754483985, 2894.8697308621163, 5073.822416215415, 5097.209932460474, 5106.191594622943, 5110.182370820651, 5117.744112794346, 5385.838424847261, 5441.483059109379, 5500.917486237709, 5529.806456773994, 5546.334439867242, 5063.468335824759, 5065.240213967934, 5070.492950704974, 5073.1122053640465, 5086.796528138833, 5429.484199001088, 5453.0, 5461.371942226536, 5461.972690136524, 5463.0, 5184.662996905189, 5303.681779093266, 5364.785408583613, 5399.705125321644, 5418.918716219338, 5082.33929589151, 5102.566281866083, 5135.537801597874, 5138.794448222179, 5145.253938178868, 3946.2304850555015, 3946.960530394774, 3963.3856752203455, 3970.583088775637, 3979.7015223857748, 5279.841604751864, 5394.732237924163, 5397.78408863641, 5423.186522021729, 5464.590155738256, 5196.402413722471, 5251.816186433456, 5256.868578285574, 5260.736963151904, 5291.550218231493, 5210.759373469445, 5230.424653288059, 5252.185911183773, 5258.237555554347, 5266.183741520071, 4884.975575122102, 5101.591872650253, 5146.408163061146, 5164.147915593885, 5166.870828229174, 5054.974725126351, 5105.923411148761, 5223.869403264949, 5274.868128296824, 5277.683338999673, 5139.460356662496, 5174.094533456555, 5178.249153872743, 5208.453112423293, 5212.166053431432], "value": 3984.026700410409, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.1864003875328, 706.452499313032, 709.2411120101491, 722.5123041946684, 773.9226077392261, 12386.071044671651, 12951.158174718637, 12985.961123110152, 13023.153495022816, 13038.869611303897, 12817.295048772314, 12930.159539629918, 13003.219806811574, 13005.804912926315, 13053.738925221514, 608.4007252855934, 757.4508481351031, 770.9845803083934, 777.063638315828, 789.1201310538737, 776.4952780692538, 785.654312102673, 788.1566723605744, 789.1043665439738, 789.3448437796615, 828.0766944856501, 828.7513745876213, 835.0105125426359, 835.8620827563444, 836.3184005035877, 819.045811629451, 823.6869989404048, 824.2128767027474, 824.9958750206271, 828.4532208742231, 612.0421540289433, 615.2555407956378, 615.7106160104788, 616.1497133955158, 616.4790751814754, 11060.0, 11172.553097876074, 11232.719182020515, 11251.60619378326, 11290.20968532203, 13223.801642975362, 13585.252811095386, 13594.0, 13600.251986140758, 13666.590002299947, 10569.471526423726, 10635.36187828725, 10738.624148154777, 10758.462076896123, 10776.5689372425, 3355.4295769719206, 3381.070205693429, 3386.6951974322183, 3396.5924089109467, 3404.489326601005, 56379.0, 56821.147682784795, 56838.0, 57654.7117264411, 57979.42020579825, 10162.745931351628, 10349.172066234683, 10351.171906247482, 10561.735956600993, 10780.353178809297, 19837.900810496143, 20273.69589456159, 20281.594368112852, 20323.491912702302, 20330.898345508176, 6651.66741662915, 6678.766243181465, 6734.6632668367365, 6755.088063111417, 6801.897971530431, 3439.50127231555, 3490.808005559719, 3497.562804649419, 3509.824508774551, 3520.841562129659, 2896.8551572421293, 2979.0, 2996.2209825445543, 3019.9245018874262, 3149.7322727567953, 533.3652952985934, 534.3240800387513, 536.6243629459394, 543.0306902179591, 545.3483087710227, 457.4464897474027, 556.9805056823072, 566.2779955556698, 627.0656721485045, 634.7334119669657, 7578.696852125963, 7715.922840771633, 7720.227977202235, 7761.301482866569, 7978.361731061501, 543.2801537962216, 557.025205889693, 560.1234068682498, 590.7814108779779, 596.6628854697083, 3624.9275014499563, 3744.4383342498845, 3771.9622803771613, 3825.8087095645105, 3847.403652433877, 59786.40213597808, 59926.70036649789, 60998.39001610016, 72555.63722181461, 103602.0, 54388.72805635946, 55020.44979550153, 55386.44613553813, 56885.715571421875, 70721.64639176772, 78245.0, 79572.6021369901, 80355.96440356034, 80481.59759201166, 80517.79223311655, 7199.0, 7309.8903516446235, 7373.668184931798, 7406.14829294638, 7439.55362678241, 36947.261054779294, 36952.81523592365, 45950.77024614855, 47011.529884700714, 48433.75783121062, 53138.93722125613, 58404.707976459846, 60687.0, 60794.69602651958, 60795.69602152138, 10853.186011049045, 11015.559377624806, 11085.944570277097, 11507.42462876836, 11660.533578657098, 12082.516699331929, 12151.39243037827, 12620.17968832023, 12728.872711272768, 12840.55058072963, 11930.642080737245, 12034.458449369975, 12129.21160124589, 12242.632721018384, 12683.048771342003, 11634.53461861516, 11645.59240426581, 11821.290722556674, 12247.142700010914, 12453.501859925502, 11747.353895535827, 11896.702582435508, 12121.939390302992, 12187.817182742088, 12464.813027804772, 9468.95265523668, 9653.613855445703, 10198.847017294895, 10455.790884182426, 10665.520051597541, 9490.240780737386, 9535.284853635867, 9554.474503902353, 9565.234781217625, 9654.56554455037], "value": 6398.387747827361, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 116.0, 116.0, 118.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 160.0, 196.0, 142.0, 155.0, 162.0, 138.0, 189.0, 131.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 174.0, 165.0, 165.0, 162.0, 163.0, 162.0, 161.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 173.0, 77.0, 78.0, 76.0, 76.0, 156.0, 77.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 153.0, 87.0, 87.0, 86.0, 144.0, 86.0, 86.0, 142.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 147.0, 148.0, 148.0, 150.0, 147.0, 148.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.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": [64.0, 63.0, 63.0, 64.0, 64.0, 65.0, 63.0, 64.0, 63.0, 68.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 93.0, 86.0, 87.0, 91.0, 86.0, 87.0, 111.0, 85.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 136.0, 131.0, 140.0, 143.0, 141.0, 149.0, 142.0, 148.0, 149.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 170.0, 168.0, 169.0, 170.0, 169.0, 172.0, 169.0, 168.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 67.0, 68.0, 69.0, 72.0, 71.0, 69.0, 67.0, 68.0, 68.0], "value": 69.3, "unit": "score"}]}]} 08:04:29 INFO - Return code: 0 08:04:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:04:29 ERROR - # TBPL SUCCESS # 08:04:29 INFO - Running post-action listener: _resource_record_post_action 08:04:29 INFO - ##### 08:04:29 INFO - ##### Finished run-tests step (success) 08:04:29 INFO - ##### 08:04:29 INFO - Running post-run listener: _resource_record_post_run 08:04:29 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524492800; Read time: 8; Write time: 386596 08:04:29 INFO - TinderboxPrint: CPU usage
13.4% 08:04:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:04:29 INFO - TinderboxPrint: I/O write bytes / time
524,492,800 / 386,596 08:04:29 INFO - TinderboxPrint: CPU idle
8,266.1 (86.5%) 08:04:29 INFO - TinderboxPrint: CPU user
1,232.8 (12.9%) 08:04:29 INFO - TinderboxPrint: Swap in / out
0 / 0 08:04:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237727744; Read time: 0; Write time: 181608 08:04:29 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286765056; Read time: 8; Write time: 204988 08:04:30 INFO - Running post-run listener: _upload_blobber_files 08:04:30 INFO - Blob upload gear active. 08:04:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:04: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 08:04: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'] 08:04: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 08:04:30 INFO - (blobuploader) - INFO - Open directory for files ... 08:04:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:04:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:04:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:31 INFO - (blobuploader) - INFO - Done attempting. 08:04:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:04:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:04:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:35 INFO - (blobuploader) - INFO - Done attempting. 08:04:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:04:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:04:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:36 INFO - (blobuploader) - INFO - Done attempting. 08:04:36 INFO - (blobuploader) - INFO - Iteration through files over. 08:04:36 INFO - Return code: 0 08:04:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:04:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:04:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e4d2354835afe90a95d323ce5e3cb34d14611cae1edcf6590af9995318e42ad204a5761f79813f43923e539091de76174013150a689bd6df11e5f5f3873f2c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3420d02fbe126a4bb9ade2e305f06ceb9767d9b6228f773a75ff7eb4c4573fd0deaa206eb4b188105419860bb4279f4d6b1349237bb23282b93a4b289644194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be41ed803b605c8d3e912b30f884f13220be44d57ef54cbef1df94e520f8d4a2fe0d17cf28a335a5c19783b342df3cc466cf130e8aef447ea4b867474c0620a"} 08:04:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:04:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:04:36 INFO - Contents: 08:04:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e4d2354835afe90a95d323ce5e3cb34d14611cae1edcf6590af9995318e42ad204a5761f79813f43923e539091de76174013150a689bd6df11e5f5f3873f2c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3420d02fbe126a4bb9ade2e305f06ceb9767d9b6228f773a75ff7eb4c4573fd0deaa206eb4b188105419860bb4279f4d6b1349237bb23282b93a4b289644194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be41ed803b605c8d3e912b30f884f13220be44d57ef54cbef1df94e520f8d4a2fe0d17cf28a335a5c19783b342df3cc466cf130e8aef447ea4b867474c0620a"} 08:04:36 INFO - Running post-run listener: copy_logs_to_upload_dir 08:04:36 INFO - Copying logs to upload dir... 08:04:36 INFO - mkdir: /builds/slave/test/build/upload/logs 08:04:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.655164 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-07 08:04:36.226706) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:04:36.230840) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756 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/6e4d2354835afe90a95d323ce5e3cb34d14611cae1edcf6590af9995318e42ad204a5761f79813f43923e539091de76174013150a689bd6df11e5f5f3873f2c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3420d02fbe126a4bb9ade2e305f06ceb9767d9b6228f773a75ff7eb4c4573fd0deaa206eb4b188105419860bb4279f4d6b1349237bb23282b93a4b289644194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be41ed803b605c8d3e912b30f884f13220be44d57ef54cbef1df94e520f8d4a2fe0d17cf28a335a5c19783b342df3cc466cf130e8aef447ea4b867474c0620a"} build_url:https://queue.taskcluster.net/v1/task/EEkP82iESuCf0IIG9Pk_uQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/EEkP82iESuCf0IIG9Pk_uQ/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/6e4d2354835afe90a95d323ce5e3cb34d14611cae1edcf6590af9995318e42ad204a5761f79813f43923e539091de76174013150a689bd6df11e5f5f3873f2c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3420d02fbe126a4bb9ade2e305f06ceb9767d9b6228f773a75ff7eb4c4573fd0deaa206eb4b188105419860bb4279f4d6b1349237bb23282b93a4b289644194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be41ed803b605c8d3e912b30f884f13220be44d57ef54cbef1df94e520f8d4a2fe0d17cf28a335a5c19783b342df3cc466cf130e8aef447ea4b867474c0620a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:04:36.262980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:04:36.263541) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465310635.190410-1715212756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004781 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:04:36.313298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:04:36.313603) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:04:36.313914) ========= ========= Total master_lag: 0.16 =========