builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1465246945.52 results: success (0) buildid: 20160606113026 builduid: 72080a92fcb041e48af3e5333fb1b521 revision: 8a363789d659493f11efc0a4621b107b10e3fef3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:25.520996) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:25.521445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:25.521743) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:25.561424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:25.561691) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 14:02:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.7M=0s 2016-06-06 14:02:25 (29.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083022 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:25.659420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:25.659720) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:25.712759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:25.713156) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a363789d659493f11efc0a4621b107b10e3fef3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8a363789d659493f11efc0a4621b107b10e3fef3 --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=82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 14:02:26,032 truncating revision to first 12 chars 2016-06-06 14:02:26,032 Setting DEBUG logging. 2016-06-06 14:02:26,033 attempt 1/10 2016-06-06 14:02:26,033 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a363789d659?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 14:02:26,325 unpacking tar archive at: fx-team-8a363789d659/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628607 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:26.357371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:26.357684) ========= script_repo_revision: 8a363789d659493f11efc0a4621b107b10e3fef3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:26.358101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:26.358364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:02:26.367560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-06 14:02:26.367901) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:02:26 INFO - MultiFileLogger online at 20160606 14:02:26 in /builds/slave/test 14:02:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:02:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:02:26 INFO - {'append_to_log': False, 14:02:26 INFO - 'base_work_dir': '/builds/slave/test', 14:02:26 INFO - 'blob_upload_branch': 'Fx-Team', 14:02:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:02:26 INFO - 'branch': 'Fx-Team', 14:02:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:26 INFO - 'config_files': ('talos/linux_config.py',), 14:02:26 INFO - 'default_actions': ('clobber', 14:02:26 INFO - 'read-buildbot-config', 14:02:26 INFO - 'download-and-extract', 14:02:26 INFO - 'populate-webroot', 14:02:26 INFO - 'create-virtualenv', 14:02:26 INFO - 'install', 14:02:26 INFO - 'run-tests'), 14:02:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:26 INFO - 'download_minidump_stackwalk': True, 14:02:26 INFO - 'download_symbols': 'ondemand', 14:02:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:26 INFO - 'installer_path': 'installer.exe', 14:02:26 INFO - 'log_level': 'info', 14:02:26 INFO - 'log_name': 'talos', 14:02:26 INFO - 'log_to_console': True, 14:02:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:02:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:02:26 INFO - 'opt_config_files': (), 14:02:26 INFO - 'pip_index': False, 14:02:26 INFO - 'sps_profile': False, 14:02:26 INFO - 'sps_profile_interval': 0, 14:02:26 INFO - 'suite': 'dromaeojs', 14:02:26 INFO - 'system_bits': '32', 14:02:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:26 INFO - 'title': 'talos-linux64-ix-066', 14:02:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:26 INFO - 'use_talos_json': True, 14:02:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:02:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:26 INFO - 'work_dir': 'build'} 14:02:26 INFO - ##### 14:02:26 INFO - ##### Running clobber step. 14:02:26 INFO - ##### 14:02:26 INFO - Running pre-action listener: _resource_record_pre_action 14:02:26 INFO - Running main action method: clobber 14:02:26 INFO - rmtree: /builds/slave/test/build 14:02:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:02:27 INFO - Running post-action listener: _resource_record_post_action 14:02:27 INFO - ##### 14:02:27 INFO - ##### Finished clobber step (success) 14:02:27 INFO - ##### 14:02:27 INFO - ##### 14:02:27 INFO - ##### Running read-buildbot-config step. 14:02:27 INFO - ##### 14:02:27 INFO - Running pre-action listener: _resource_record_pre_action 14:02:27 INFO - Running main action method: read_buildbot_config 14:02:27 INFO - Using buildbot properties: 14:02:27 INFO - { 14:02:27 INFO - "project": "", 14:02:27 INFO - "product": "firefox", 14:02:27 INFO - "script_repo_revision": "production", 14:02:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:02:27 INFO - "repository": "", 14:02:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:02:27 INFO - "buildid": "20160606113026", 14:02:27 INFO - "pgo_build": "True", 14:02:27 INFO - "basedir": "/builds/slave/test", 14:02:27 INFO - "buildnumber": 161, 14:02:27 INFO - "slavename": "talos-linux64-ix-066", 14:02:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:02:27 INFO - "platform": "ubuntu64_hw", 14:02:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:02:27 INFO - "branch": "fx-team", 14:02:27 INFO - "repo_path": "integration/fx-team", 14:02:27 INFO - "revision": "8a363789d659493f11efc0a4621b107b10e3fef3", 14:02:27 INFO - "stage_platform": "linux64-pgo", 14:02:27 INFO - "builduid": "72080a92fcb041e48af3e5333fb1b521", 14:02:27 INFO - "slavebuilddir": "test" 14:02:27 INFO - } 14:02:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:02:27 INFO - Running post-action listener: _resource_record_post_action 14:02:27 INFO - ##### 14:02:27 INFO - ##### Finished read-buildbot-config step (success) 14:02:27 INFO - ##### 14:02:27 INFO - ##### 14:02:27 INFO - ##### Running download-and-extract step. 14:02:27 INFO - ##### 14:02:27 INFO - Running pre-action listener: _resource_record_pre_action 14:02:27 INFO - Running main action method: download_and_extract 14:02:27 INFO - mkdir: /builds/slave/test/build/tests 14:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:27 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:02:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:02:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:02:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:02:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:02:29 INFO - Downloaded 1361 bytes. 14:02:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:02:29 INFO - Using the following test package requirements: 14:02:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:02:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:29 INFO - u'jsshell-linux-x86_64.zip'], 14:02:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:02:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:02:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:02:29 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')]} 14:02:29 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:31 INFO - Downloaded 24443829 bytes. 14:02:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:02:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:02:32 INFO - Return code: 0 14:02:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:32 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:02:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:49 INFO - Downloaded 24443829 bytes. 14:02:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:02:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:02:50 INFO - Return code: 0 14:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:50 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:02:51 INFO - Downloaded 10833369 bytes. 14:02:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:02:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:02:52 INFO - Return code: 0 14:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:52 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:02:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:02:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:02:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:02:53 INFO - Downloaded 59193663 bytes. 14:02:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:02:53 INFO - mkdir: /builds/slave/test/properties 14:02:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:02:53 INFO - Writing to file /builds/slave/test/properties/build_url 14:02:53 INFO - Contents: 14:02:53 INFO - build_url:https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:02:54 INFO - Running post-action listener: _resource_record_post_action 14:02:54 INFO - Running post-action listener: set_extra_try_arguments 14:02:54 INFO - ##### 14:02:54 INFO - ##### Finished download-and-extract step (success) 14:02:54 INFO - ##### 14:02:54 INFO - ##### 14:02:54 INFO - ##### Running populate-webroot step. 14:02:54 INFO - ##### 14:02:54 INFO - Running pre-action listener: _resource_record_pre_action 14:02:54 INFO - Running main action method: populate_webroot 14:02:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:54 INFO - '--tppagecycles', 14:02:54 INFO - '7'], 14:02:54 INFO - 'tests': ['tsvgm']}}, 14:02:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:02:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:02:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:02:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:02:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:02:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'talos_options': ['--disable-e10s'], 14:02:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'talos_options': ['--disable-e10s'], 14:02:54 INFO - 'tests': ['damp', 'tps']}, 14:02:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'tests': ['damp', 'tps']}, 14:02:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:02:54 INFO - 'tests': ['dromaeo_dom']}, 14:02:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:02:54 INFO - 'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore', 14:02:54 INFO - 'tabpaint']}, 14:02:54 INFO - 'other-e10s': {'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore', 14:02:54 INFO - 'tabpaint']}, 14:02:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore', 14:02:54 INFO - 'tabpaint']}, 14:02:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore', 14:02:54 INFO - 'tabpaint']}, 14:02:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:02:54 INFO - 'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore', 14:02:54 INFO - 'tabpaint']}, 14:02:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:02:54 INFO - 'tests': ['a11yr', 14:02:54 INFO - 'ts_paint', 14:02:54 INFO - 'tpaint', 14:02:54 INFO - 'sessionrestore', 14:02:54 INFO - 'sessionrestore_no_auto_restore', 14:02:54 INFO - 'tabpaint']}, 14:02:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:02:54 INFO - 'tests': ['tsvgx', 14:02:54 INFO - 'tsvgr_opacity', 14:02:54 INFO - 'tart', 14:02:54 INFO - 'tscrollx', 14:02:54 INFO - 'cart']}, 14:02:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:02:54 INFO - 'tsvgr_opacity', 14:02:54 INFO - 'tart', 14:02:54 INFO - 'tscrollx', 14:02:54 INFO - 'cart']}, 14:02:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'talos_options': ['--disable-e10s'], 14:02:54 INFO - 'tests': ['tp5o']}, 14:02:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'tests': ['tp5o']}, 14:02:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'talos_options': ['--disable-e10s', 14:02:54 INFO - '--xperf_path', 14:02:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:54 INFO - 'tests': ['tp5n']}, 14:02:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:54 INFO - 'talos_options': ['--xperf_path', 14:02:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:54 INFO - 'tests': ['tp5n']}}, 14:02:54 INFO - 'talos.zip': {'path': '', 14:02:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:54 INFO - Running post-action listener: _resource_record_post_action 14:02:54 INFO - ##### 14:02:54 INFO - ##### Finished populate-webroot step (success) 14:02:54 INFO - ##### 14:02:54 INFO - ##### 14:02:54 INFO - ##### Running create-virtualenv step. 14:02:54 INFO - ##### 14:02:54 INFO - Running pre-action listener: _resource_record_pre_action 14:02:54 INFO - Running main action method: create_virtualenv 14:02:54 INFO - Creating virtualenv /builds/slave/test/build/venv 14:02:54 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 14:02:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:02:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:54 INFO - Using real prefix '/usr' 14:02:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:02:54 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:56 INFO - Installing pip.................done. 14:02:56 INFO - Return code: 0 14:02:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02:56 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')]} 14:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:56 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')]} 14:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:56 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 0x7f09f908cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', '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 14:02:56 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 14:02:56 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 14:02:56 INFO - Using env: {'DISPLAY': ':0', 14:02:56 INFO - 'HOME': '/home/cltbld', 14:02:56 INFO - 'LANG': 'en_US.UTF-8', 14:02:56 INFO - 'LANGUAGE': 'en_US:en', 14:02:56 INFO - 'LOGNAME': 'cltbld', 14:02:56 INFO - 'MAIL': '/var/mail/cltbld', 14:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:56 INFO - 'MOZ_NO_REMOTE': '1', 14:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:56 INFO - 'NO_EM_RESTART': '1', 14:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:56 INFO - 'PWD': '/builds/slave/test', 14:02:56 INFO - 'SHELL': '/bin/bash', 14:02:56 INFO - 'SHLVL': '1', 14:02:56 INFO - 'TERM': 'linux', 14:02:56 INFO - 'TMOUT': '86400', 14:02:56 INFO - 'USER': 'cltbld', 14:02:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:56 INFO - '_': '/tools/buildbot/bin/python'} 14:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:57 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 14:02:57 INFO - Cleaning up... 14:02:57 INFO - Return code: 0 14:02:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:02:57 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')]} 14:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:57 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')]} 14:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:57 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 0x7f09f908cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', '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 14:02:57 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 14:02:57 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 14:02:57 INFO - Using env: {'DISPLAY': ':0', 14:02:57 INFO - 'HOME': '/home/cltbld', 14:02:57 INFO - 'LANG': 'en_US.UTF-8', 14:02:57 INFO - 'LANGUAGE': 'en_US:en', 14:02:57 INFO - 'LOGNAME': 'cltbld', 14:02:57 INFO - 'MAIL': '/var/mail/cltbld', 14:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:57 INFO - 'MOZ_NO_REMOTE': '1', 14:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:57 INFO - 'NO_EM_RESTART': '1', 14:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:57 INFO - 'PWD': '/builds/slave/test', 14:02:57 INFO - 'SHELL': '/bin/bash', 14:02:57 INFO - 'SHLVL': '1', 14:02:57 INFO - 'TERM': 'linux', 14:02:57 INFO - 'TMOUT': '86400', 14:02:57 INFO - 'USER': 'cltbld', 14:02:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:57 INFO - '_': '/tools/buildbot/bin/python'} 14:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:57 INFO - Downloading/unpacking psutil>=3.1.1 14:02:57 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 14:02:57 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 14:02:57 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 14:02:57 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 14:02:57 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 14:02:57 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 14:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:59 INFO - Installing collected packages: psutil 14:02:59 INFO - Running setup.py install for psutil 14:02:59 INFO - building 'psutil._psutil_linux' extension 14:02:59 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 14:02:59 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 14:02:59 INFO - building 'psutil._psutil_posix' extension 14:02:59 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 14:02:59 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 14:02:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:59 INFO - Successfully installed psutil 14:02:59 INFO - Cleaning up... 14:02:59 INFO - Return code: 0 14:02:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09f908cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', '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 14:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:02:59 INFO - Using env: {'DISPLAY': ':0', 14:02:59 INFO - 'HOME': '/home/cltbld', 14:02:59 INFO - 'LANG': 'en_US.UTF-8', 14:02:59 INFO - 'LANGUAGE': 'en_US:en', 14:02:59 INFO - 'LOGNAME': 'cltbld', 14:02:59 INFO - 'MAIL': '/var/mail/cltbld', 14:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:59 INFO - 'MOZ_NO_REMOTE': '1', 14:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:59 INFO - 'NO_EM_RESTART': '1', 14:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:59 INFO - 'PWD': '/builds/slave/test', 14:02:59 INFO - 'SHELL': '/bin/bash', 14:02:59 INFO - 'SHLVL': '1', 14:02:59 INFO - 'TERM': 'linux', 14:02:59 INFO - 'TMOUT': '86400', 14:02:59 INFO - 'USER': 'cltbld', 14:02:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:59 INFO - '_': '/tools/buildbot/bin/python'} 14:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:03:01 INFO - Installing collected packages: mozsystemmonitor 14:03:01 INFO - Running setup.py install for mozsystemmonitor 14:03:02 INFO - Successfully installed mozsystemmonitor 14:03:02 INFO - Cleaning up... 14:03:02 INFO - Return code: 0 14:03:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f09f908cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', '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 14:03:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:03:02 INFO - Using env: {'DISPLAY': ':0', 14:03:02 INFO - 'HOME': '/home/cltbld', 14:03:02 INFO - 'LANG': 'en_US.UTF-8', 14:03:02 INFO - 'LANGUAGE': 'en_US:en', 14:03:02 INFO - 'LOGNAME': 'cltbld', 14:03:02 INFO - 'MAIL': '/var/mail/cltbld', 14:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:02 INFO - 'MOZ_NO_REMOTE': '1', 14:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:02 INFO - 'NO_EM_RESTART': '1', 14:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:02 INFO - 'PWD': '/builds/slave/test', 14:03:02 INFO - 'SHELL': '/bin/bash', 14:03:02 INFO - 'SHLVL': '1', 14:03:02 INFO - 'TERM': 'linux', 14:03:02 INFO - 'TMOUT': '86400', 14:03:02 INFO - 'USER': 'cltbld', 14:03:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:02 INFO - '_': '/tools/buildbot/bin/python'} 14:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:02 INFO - Downloading/unpacking jsonschema==2.5.1 14:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:03:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:04 INFO - Downloading functools32-3.2.3-2.tar.gz 14:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:03:04 INFO - warning: no files found matching '*.txt' 14:03:04 INFO - no previously-included directories found matching 'build' 14:03:04 INFO - no previously-included directories found matching 'dist' 14:03:04 INFO - no previously-included directories found matching '.git*' 14:03:04 INFO - Installing collected packages: jsonschema, functools32 14:03:04 INFO - Running setup.py install for functools32 14:03:04 INFO - warning: no files found matching '*.txt' 14:03:04 INFO - no previously-included directories found matching 'build' 14:03:04 INFO - no previously-included directories found matching 'dist' 14:03:04 INFO - no previously-included directories found matching '.git*' 14:03:04 INFO - Successfully installed jsonschema functools32 14:03:04 INFO - Cleaning up... 14:03:04 INFO - Return code: 0 14:03:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f09f908cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', '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 14:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:03:04 INFO - Using env: {'DISPLAY': ':0', 14:03:04 INFO - 'HOME': '/home/cltbld', 14:03:04 INFO - 'LANG': 'en_US.UTF-8', 14:03:04 INFO - 'LANGUAGE': 'en_US:en', 14:03:04 INFO - 'LOGNAME': 'cltbld', 14:03:04 INFO - 'MAIL': '/var/mail/cltbld', 14:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:04 INFO - 'MOZ_NO_REMOTE': '1', 14:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:04 INFO - 'NO_EM_RESTART': '1', 14:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:04 INFO - 'PWD': '/builds/slave/test', 14:03:04 INFO - 'SHELL': '/bin/bash', 14:03:04 INFO - 'SHLVL': '1', 14:03:04 INFO - 'TERM': 'linux', 14:03:04 INFO - 'TMOUT': '86400', 14:03:04 INFO - 'USER': 'cltbld', 14:03:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:04 INFO - '_': '/tools/buildbot/bin/python'} 14:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:04 INFO - Downloading/unpacking blobuploader==1.2.4 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:06 INFO - Downloading blobuploader-1.2.4.tar.gz 14:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:03:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:03:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:07 INFO - Downloading docopt-0.6.1.tar.gz 14:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:03:07 INFO - Installing collected packages: blobuploader, requests, docopt 14:03:07 INFO - Running setup.py install for blobuploader 14:03:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:03:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:03:07 INFO - Running setup.py install for requests 14:03:08 INFO - Running setup.py install for docopt 14:03:08 INFO - Successfully installed blobuploader requests docopt 14:03:08 INFO - Cleaning up... 14:03:08 INFO - Return code: 0 14:03:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:08 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 0x7f09f908cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', '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 14:03:08 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 14:03:08 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 14:03:08 INFO - Using env: {'DISPLAY': ':0', 14:03:08 INFO - 'HOME': '/home/cltbld', 14:03:08 INFO - 'LANG': 'en_US.UTF-8', 14:03:08 INFO - 'LANGUAGE': 'en_US:en', 14:03:08 INFO - 'LOGNAME': 'cltbld', 14:03:08 INFO - 'MAIL': '/var/mail/cltbld', 14:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:08 INFO - 'MOZ_NO_REMOTE': '1', 14:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:08 INFO - 'NO_EM_RESTART': '1', 14:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:08 INFO - 'PWD': '/builds/slave/test', 14:03:08 INFO - 'SHELL': '/bin/bash', 14:03:08 INFO - 'SHLVL': '1', 14:03:08 INFO - 'TERM': 'linux', 14:03:08 INFO - 'TMOUT': '86400', 14:03:08 INFO - 'USER': 'cltbld', 14:03:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:08 INFO - '_': '/tools/buildbot/bin/python'} 14:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:03:08 INFO - Running setup.py (path:/tmp/pip-puTi8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:03:08 INFO - Running setup.py (path:/tmp/pip-QegVee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:03:08 INFO - Running setup.py (path:/tmp/pip-LG2_6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:03:08 INFO - Running setup.py (path:/tmp/pip-k4GojG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:03:08 INFO - Running setup.py (path:/tmp/pip-i_2f7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:03:08 INFO - Running setup.py (path:/tmp/pip-YWqTfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:03:08 INFO - Running setup.py (path:/tmp/pip-TyHMiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:03:08 INFO - Running setup.py (path:/tmp/pip-1csr3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:03:08 INFO - Running setup.py (path:/tmp/pip-bAkOcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:03:09 INFO - Running setup.py (path:/tmp/pip-MF9qco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:03:09 INFO - Running setup.py (path:/tmp/pip-1IQsuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:03:09 INFO - Running setup.py (path:/tmp/pip-69uWgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:03:09 INFO - Running setup.py (path:/tmp/pip-T2a0Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:03:09 INFO - Running setup.py (path:/tmp/pip-Qi7tCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:09 INFO - Running setup.py (path:/tmp/pip-kjgagj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:03:09 INFO - Running setup.py (path:/tmp/pip-rIJC9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:03:09 INFO - Running setup.py (path:/tmp/pip-ILw1VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:03:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:03:09 INFO - Running setup.py install for manifestparser 14:03:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:03:09 INFO - Running setup.py install for mozcrash 14:03:09 INFO - Running setup.py install for mozdebug 14:03:09 INFO - Running setup.py install for mozdevice 14:03:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Running setup.py install for mozfile 14:03:10 INFO - Running setup.py install for mozhttpd 14:03:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Running setup.py install for mozinfo 14:03:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Running setup.py install for mozInstall 14:03:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Running setup.py install for mozleak 14:03:10 INFO - Running setup.py install for mozlog 14:03:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Running setup.py install for moznetwork 14:03:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Running setup.py install for mozprocess 14:03:10 INFO - Running setup.py install for mozprofile 14:03:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:03:10 INFO - Running setup.py install for mozrunner 14:03:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:03:11 INFO - Running setup.py install for mozscreenshot 14:03:11 INFO - Running setup.py install for moztest 14:03:11 INFO - Running setup.py install for mozversion 14:03:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:03:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:11 INFO - Cleaning up... 14:03:11 INFO - Return code: 0 14:03:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:11 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 0x7f09f908cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', '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 14:03:11 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 14:03:11 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 14:03:11 INFO - Using env: {'DISPLAY': ':0', 14:03:11 INFO - 'HOME': '/home/cltbld', 14:03:11 INFO - 'LANG': 'en_US.UTF-8', 14:03:11 INFO - 'LANGUAGE': 'en_US:en', 14:03:11 INFO - 'LOGNAME': 'cltbld', 14:03:11 INFO - 'MAIL': '/var/mail/cltbld', 14:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:11 INFO - 'MOZ_NO_REMOTE': '1', 14:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:11 INFO - 'NO_EM_RESTART': '1', 14:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:11 INFO - 'PWD': '/builds/slave/test', 14:03:11 INFO - 'SHELL': '/bin/bash', 14:03:11 INFO - 'SHLVL': '1', 14:03:11 INFO - 'TERM': 'linux', 14:03:11 INFO - 'TMOUT': '86400', 14:03:11 INFO - 'USER': 'cltbld', 14:03:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:11 INFO - '_': '/tools/buildbot/bin/python'} 14:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:03:11 INFO - Running setup.py (path:/tmp/pip-fTKGVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:03:11 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)) 14:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:03:11 INFO - Running setup.py (path:/tmp/pip-tgkjmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:03:11 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)) 14:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:03:11 INFO - Running setup.py (path:/tmp/pip-kFy6WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:03:11 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)) 14:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:03:11 INFO - Running setup.py (path:/tmp/pip-X1TpFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:03:11 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)) 14:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:03:11 INFO - Running setup.py (path:/tmp/pip-rpulLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:03:11 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)) 14:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:03:11 INFO - Running setup.py (path:/tmp/pip-cAI29a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:03:12 INFO - Running setup.py (path:/tmp/pip-Vb4iuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:03:12 INFO - Running setup.py (path:/tmp/pip-P8RKP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:03:12 INFO - Running setup.py (path:/tmp/pip-yEAPDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:03:12 INFO - Running setup.py (path:/tmp/pip-akWCeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:03:12 INFO - Running setup.py (path:/tmp/pip-Jjpolx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:03:12 INFO - Running setup.py (path:/tmp/pip-rCk7Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:03:12 INFO - Running setup.py (path:/tmp/pip-Mqj4Gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:03:12 INFO - Running setup.py (path:/tmp/pip-VFTpUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:12 INFO - Running setup.py (path:/tmp/pip-8d5oMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:03:12 INFO - Running setup.py (path:/tmp/pip-D0e74s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:03:12 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)) 14:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:03:12 INFO - Running setup.py (path:/tmp/pip-Oa0EV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:03:12 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)) 14:03:12 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)) 14:03:12 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)) 14:03:12 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)) 14:03:12 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)) 14:03:12 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)) 14:03:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:12 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 14:03:12 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 14:03:12 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 14:03:12 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 14:03:12 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 14:03:12 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 14:03:14 INFO - Downloading blessings-1.6.tar.gz 14:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:14 INFO - Installing collected packages: blessings 14:03:14 INFO - Running setup.py install for blessings 14:03:14 INFO - Successfully installed blessings 14:03:14 INFO - Cleaning up... 14:03:15 INFO - Return code: 0 14:03:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:15 INFO - Reading from file tmpfile_stdout 14:03:15 INFO - Current package versions: 14:03:15 INFO - argparse == 1.2.1 14:03:15 INFO - blessings == 1.6 14:03:15 INFO - blobuploader == 1.2.4 14:03:15 INFO - docopt == 0.6.1 14:03:15 INFO - functools32 == 3.2.3-2 14:03:15 INFO - jsonschema == 2.5.1 14:03:15 INFO - manifestparser == 1.1 14:03:15 INFO - mozInstall == 1.12 14:03:15 INFO - mozcrash == 0.17 14:03:15 INFO - mozdebug == 0.1 14:03:15 INFO - mozdevice == 0.48 14:03:15 INFO - mozfile == 1.2 14:03:15 INFO - mozhttpd == 0.7 14:03:15 INFO - mozinfo == 0.9 14:03:15 INFO - mozleak == 0.1 14:03:15 INFO - mozlog == 3.2 14:03:15 INFO - moznetwork == 0.27 14:03:15 INFO - mozprocess == 0.22 14:03:15 INFO - mozprofile == 0.28 14:03:15 INFO - mozrunner == 6.11 14:03:15 INFO - mozscreenshot == 0.1 14:03:15 INFO - mozsystemmonitor == 0.3 14:03:15 INFO - moztest == 0.7 14:03:15 INFO - mozversion == 1.4 14:03:15 INFO - psutil == 3.1.1 14:03:15 INFO - requests == 1.2.3 14:03:15 INFO - wsgiref == 0.1.2 14:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03: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')]} 14:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:15 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 0x7f09f908cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', '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 14:03:15 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 14:03:15 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 14:03:15 INFO - Using env: {'DISPLAY': ':0', 14:03:15 INFO - 'HOME': '/home/cltbld', 14:03:15 INFO - 'LANG': 'en_US.UTF-8', 14:03:15 INFO - 'LANGUAGE': 'en_US:en', 14:03:15 INFO - 'LOGNAME': 'cltbld', 14:03:15 INFO - 'MAIL': '/var/mail/cltbld', 14:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:15 INFO - 'MOZ_NO_REMOTE': '1', 14:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:15 INFO - 'NO_EM_RESTART': '1', 14:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:15 INFO - 'PWD': '/builds/slave/test', 14:03:15 INFO - 'SHELL': '/bin/bash', 14:03:15 INFO - 'SHLVL': '1', 14:03:15 INFO - 'TERM': 'linux', 14:03:15 INFO - 'TMOUT': '86400', 14:03:15 INFO - 'USER': 'cltbld', 14:03:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:15 INFO - '_': '/tools/buildbot/bin/python'} 14:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:15 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)) 14:03:15 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)) 14:03:15 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)) 14:03:15 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)) 14:03:15 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)) 14:03:15 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)) 14:03:15 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)) 14:03:15 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)) 14:03:15 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)) 14:03:15 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)) 14:03:15 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)) 14:03:15 INFO - Cleaning up... 14:03:15 INFO - Return code: 0 14:03:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:03: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')]} 14:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09f908cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', '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 14:03: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'] in /builds/slave/test/build 14:03: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 14:03:15 INFO - Using env: {'DISPLAY': ':0', 14:03:15 INFO - 'HOME': '/home/cltbld', 14:03:15 INFO - 'LANG': 'en_US.UTF-8', 14:03:15 INFO - 'LANGUAGE': 'en_US:en', 14:03:15 INFO - 'LOGNAME': 'cltbld', 14:03:15 INFO - 'MAIL': '/var/mail/cltbld', 14:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:15 INFO - 'MOZ_NO_REMOTE': '1', 14:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:15 INFO - 'NO_EM_RESTART': '1', 14:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:15 INFO - 'PWD': '/builds/slave/test', 14:03:15 INFO - 'SHELL': '/bin/bash', 14:03:15 INFO - 'SHLVL': '1', 14:03:15 INFO - 'TERM': 'linux', 14:03:15 INFO - 'TMOUT': '86400', 14:03:15 INFO - 'USER': 'cltbld', 14:03:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:15 INFO - '_': '/tools/buildbot/bin/python'} 14:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:03:15 INFO - Cleaning up... 14:03:15 INFO - Return code: 0 14:03:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:03: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')]} 14:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09f908cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', '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 14:03: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', 'flake8'] in /builds/slave/test/build 14:03: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 flake8 14:03:15 INFO - Using env: {'DISPLAY': ':0', 14:03:15 INFO - 'HOME': '/home/cltbld', 14:03:15 INFO - 'LANG': 'en_US.UTF-8', 14:03:15 INFO - 'LANGUAGE': 'en_US:en', 14:03:15 INFO - 'LOGNAME': 'cltbld', 14:03:15 INFO - 'MAIL': '/var/mail/cltbld', 14:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:15 INFO - 'MOZ_NO_REMOTE': '1', 14:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:15 INFO - 'NO_EM_RESTART': '1', 14:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:15 INFO - 'PWD': '/builds/slave/test', 14:03:15 INFO - 'SHELL': '/bin/bash', 14:03:15 INFO - 'SHLVL': '1', 14:03:15 INFO - 'TERM': 'linux', 14:03:15 INFO - 'TMOUT': '86400', 14:03:15 INFO - 'USER': 'cltbld', 14:03:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:15 INFO - '_': '/tools/buildbot/bin/python'} 14:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:15 INFO - Downloading/unpacking flake8 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:03:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:03:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:18 INFO - no previously-included directories found matching 'docs/_build' 14:03:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:03:18 INFO - Running setup.py install for pep8 14:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:18 INFO - no previously-included directories found matching 'docs/_build' 14:03:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:03:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:03:18 INFO - Cleaning up... 14:03:18 INFO - Return code: 0 14:03:18 INFO - Running post-action listener: _resource_record_post_action 14:03:18 INFO - Running post-action listener: _start_resource_monitoring 14:03:18 INFO - Starting resource monitoring. 14:03:18 INFO - ##### 14:03:18 INFO - ##### Finished create-virtualenv step (success) 14:03:18 INFO - ##### 14:03:18 INFO - ##### 14:03:18 INFO - ##### Running install step. 14:03:18 INFO - ##### 14:03:18 INFO - Running pre-action listener: _resource_record_pre_action 14:03:18 INFO - Running main action method: install 14:03:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:18 INFO - Reading from file tmpfile_stdout 14:03:18 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:03:19 INFO - Reading from file tmpfile_stdout 14:03:19 INFO - Output received: 14:03:19 INFO - Usage: mozinstall [options] installer 14:03:19 INFO - Options: 14:03:19 INFO - -h, --help show this help message and exit 14:03:19 INFO - -d DEST, --destination=DEST 14:03:19 INFO - Directory to install application into. [default: 14:03:19 INFO - "/builds/slave/test"] 14:03:19 INFO - --app=APP Application being installed. [default: firefox] 14:03:19 INFO - mkdir: /builds/slave/test/build/application 14:03:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:03:35 INFO - Reading from file tmpfile_stdout 14:03:35 INFO - Output received: 14:03:35 INFO - /builds/slave/test/build/application/firefox/firefox 14:03:35 INFO - Running post-action listener: _resource_record_post_action 14:03:35 INFO - ##### 14:03:35 INFO - ##### Finished install step (success) 14:03:35 INFO - ##### 14:03:35 INFO - ##### 14:03:35 INFO - ##### Running run-tests step. 14:03:35 INFO - ##### 14:03:35 INFO - Running pre-action listener: _resource_record_pre_action 14:03:35 INFO - Running main action method: run_tests 14:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:03:35 INFO - Python 2.7.3 14:03:35 INFO - Return code: 0 14:03:35 INFO - grabbing minidump binary from tooltool 14:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:35 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 0x1e4c1c0>, '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 0x1e4d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:03:35 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 14:03:35 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 14:03:35 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 14:03:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:35 INFO - Return code: 0 14:03:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:03:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:03:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:03:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:03:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:03:36 INFO - Return code: 0 14:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:03:36 INFO - Using env: {'DISPLAY': ':0', 14:03:36 INFO - 'HOME': '/home/cltbld', 14:03:36 INFO - 'LANG': 'en_US.UTF-8', 14:03:36 INFO - 'LANGUAGE': 'en_US:en', 14:03:36 INFO - 'LOGNAME': 'cltbld', 14:03:36 INFO - 'MAIL': '/var/mail/cltbld', 14:03:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:03:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:36 INFO - 'MOZ_NO_REMOTE': '1', 14:03:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:36 INFO - 'NO_EM_RESTART': '1', 14:03:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:36 INFO - 'PWD': '/builds/slave/test', 14:03:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:03:36 INFO - 'SHELL': '/bin/bash', 14:03:36 INFO - 'SHLVL': '1', 14:03:36 INFO - 'TERM': 'linux', 14:03:36 INFO - 'TMOUT': '86400', 14:03:36 INFO - 'USER': 'cltbld', 14:03:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501', 14:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:36 INFO - '_': '/tools/buildbot/bin/python'} 14:03:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:03:37 INFO - mozversion application_buildid: 20160606113026 14:03:37 INFO - mozversion application_changeset: 8a363789d659493f11efc0a4621b107b10e3fef3 14:03:37 INFO - mozversion application_display_name: Nightly 14:03:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:37 INFO - mozversion application_name: Firefox 14:03:37 INFO - mozversion application_remotingname: firefox 14:03:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:03:37 INFO - mozversion application_vendor: Mozilla 14:03:37 INFO - mozversion application_version: 49.0a1 14:03:37 INFO - mozversion platform_buildid: 20160606113026 14:03:37 INFO - mozversion platform_changeset: 8a363789d659493f11efc0a4621b107b10e3fef3 14:03:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:03:37 INFO - mozversion platform_version: 49.0a1 14:03:37 INFO - using testdate: 1465247017 14:03:37 INFO - actual date: 1465247017 14:03:37 INFO - starting webserver on 'localhost:45374' 14:03:37 INFO - SUITE-START | Running 2 tests 14:03:37 INFO - TEST-START | dromaeo_css 14:03:37 INFO - operating with platform_type : linux_ 14:03:37 INFO - Initialising browser for dromaeo_css test... 14:03:37 INFO - TEST-INFO | started process 2685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd7si12/profile http://localhost:45374/getInfo.html) 14:03:41 INFO - PROCESS | 2685 | __metrics Screen width/height:1600/1200 14:03:41 INFO - PROCESS | 2685 | colorDepth:24 14:03:41 INFO - PROCESS | 2685 | Browser inner width/height: 1024/697 14:03:41 INFO - PROCESS | 2685 | __metrics 14:03:42 ERROR - PROCESS | 2685 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:03:43 INFO - PROCESS | 2685 | console.error: PushService: 14:03:43 INFO - PROCESS | 2685 | stateChangeProcessEnqueue: Error transitioning state 14:03:43 INFO - PROCESS | 2685 | UnknownError 14:03:43 INFO - TEST-INFO | 2685: exit 0 14:03:43 INFO - Browser initialized. 14:03:43 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:43 INFO - TEST-INFO | started process 2852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd7si12/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:55 INFO - PROCESS | 2852 | RSS: Main: 160133120 14:03:55 INFO - PROCESS | 2852 | 14:04:46 INFO - PROCESS | 2852 | 1465247086678 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] 14:06:54 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:45374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45374/tests/dromaeo/cssquery-ext.html) 14:06:55 INFO - PROCESS | 2852 | RSS: Main: 294604800 14:06:55 INFO - PROCESS | 2852 | 14:09:58 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:45374/tests/dromaeo/cssquery-ext.html (next: http://localhost:45374/tests/dromaeo/cssquery-jquery.html) 14:09:59 INFO - PROCESS | 2852 | RSS: Main: 240443392 14:09:59 INFO - PROCESS | 2852 | 14:13:01 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:45374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45374/tests/dromaeo/cssquery-mootools.html) 14:13:01 INFO - PROCESS | 2852 | RSS: Main: 245796864 14:13:01 INFO - PROCESS | 2852 | 14:16:03 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:45374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45374/tests/dromaeo/cssquery-prototype.html) 14:16:04 INFO - PROCESS | 2852 | RSS: Main: 236941312 14:16:04 INFO - PROCESS | 2852 | 14:19:07 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:45374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45374/tests/dromaeo/cssquery-yui.html) 14:19:07 INFO - PROCESS | 2852 | RSS: Main: 225157120 14:19:07 INFO - PROCESS | 2852 | 14:22:10 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:45374/tests/dromaeo/cssquery-yui.html (next: http://localhost:45374/tests/dromaeo/cssquery-dojo.html) 14:22:10 INFO - PROCESS | 2852 | RSS: Main: 273551360 14:22:10 INFO - PROCESS | 2852 | 14:22:10 INFO - PROCESS | 2852 | __start_tp_report 14:22:10 INFO - PROCESS | 2852 | _x_x_mozilla_page_load 14:22:10 INFO - PROCESS | 2852 | _x_x_mozilla_page_load_details 14:22:10 INFO - PROCESS | 2852 | |i|pagename|runs| 14:22:10 INFO - PROCESS | 2852 | |0;dojo.html;3101.534769784532;3116.766242531811;3130.34262804811;3138.5135304027885;3173.3970545596335;5294.947050529494;5341.679499230044;5366.973165134169;5453.5364494018;5497.697626630534;5436.891262174754;5438.238646589481;5455.236266922634;5461.5357694595905;5499.972500137504;4884.682495637781;4958.479359667237;4971.37857767779;4974.527419895104;5106.183010718286;5032.220005899091;5060.746962651852;5095.6178286628465;5108.667936584129;5115.718635475047;4878.292647566101;4881.951180488185;4939.234418665113;4960.925586116211;4968.453470118284;4945.703257804544;4949.208126699711;4956.975215123901;4968.428630707479;5003.424606170301;4955.925661115086;4974.129527332702;4987.551120399182;4990.675606085629;5022.84931452057;5248.527632513054;5320.095583750772;5392.595555333366;5401.7299135043095;5480.04099282624;5746.9712651436475;5783.363829978699;5793.855153621151;5795.681237531934;5799.420057994209;5836.270466191726;5840.766369345221;5847.853803654943;5857.062869940789;5859.472647461749;5319.3616765987945;5422.728863556807;5497.257870187514;5498.092814685572;5580.469855363734;6050.3599984088605;6053.599370122627;6061.932595448327;6083.300420451616;6094.360092190344;5831.358550559435;5837.824865254049;5840.3575606683235;5842.2405087338375;5852.970735146297;5608.158776183605;5766.94233057664;5833.445822646841;5842.737076831553;5876.764929402776;5732.398098199712;5753.367129615739;5770.653760774367;5777.2200752897825;5782.479576838105;5673.149027645886;5749.051406517878;5804.6807425592;5815.156802263648;5817;4356.259435895905;4386.978065109654;4411.801468933906;4436.3123715824095;4457.175422546839;3968.1270120573427;3969.047428617169;3969.7816620086173;3981.820818063194;4003.499562554681;5444.564434845203;5582.330120385498;5595.132754423071;5596.86007849807;5598.552115830724;5836.67898265591;5890.9410905891245;5894.882102358015;5918.556108291896;5952.375000624958;5577.581681373913;5585.916211256835;5590.301212348457;5590.636608620427;5592.5246354059545;4913.287573301851;4964.90070198594;5069.340985671913;5074.162763144113;5120.206368012964;5973.104034394789;6013.759449622054;6019.247594050744;6021.217241758543;6059.848503787441;5873.442023007893;5889.263842019747;5890.587658863838;5892;5893.793717220048;5932.1694962706115;6038.275406951194;6044.063170208625;6070;6078.665673388006;5797.8550536236935;5813.680247586423;5813.970930145322;5814.970925145347;5859.179714840011;5882.323532793784;5885.529157667462;5907.793227237026;5943.138244954371;5951.16683664296;5534.418886017072;5683.914741278967;5690.743916523849;5729.828105156852;5771.538276937751;5740.598158128891;5760.107183386414;5763.4812866842185;5765.538756899354;5769.913451298318;5654.038813401649;5668.886622267449;5670.914936275876;5672.290963629546;5674.77300907959;5623.2408624835125;5629.774809007594;5670.432956704297;5705.828825135252;5709.942900571107;5541.362743284574;5619.381867994435;5627.071533196977;5629.099344104923;5637.52081073097 14:22:10 INFO - PROCESS | 2852 | |1;ext.html;580.9941900580993;607.1772747926559;620.6493331267833;621.0963048764046;637.3435361577576;30404;43683.563164368345;44520.554794452044;44652.77673611636;44778.32832507515;44596.554034459725;45380.77309613456;45388.3191752124;45449.77275113628;45450;8094.838103237932;8705.825883482326;8943.50810705411;10619.84070238947;10857.131429485662;10242.180625549976;10661.147108231324;10673.626423075193;10683.732906677318;10686.732831679192;10714.839277410845;10818.296810707317;10819.621313254038;10838;10864.728381790439;10749.83875241872;10858.402787846666;10865.83701244482;10867.51096200665;10867.619633312876;10703.892961070367;10791.892081079246;10800.51397687106;10805.351678899291;10807.837882431691;43719.12561748779;44171.558284417064;44249;44258.33612495815;44345.55654443479;3472.3576138414473;3495.2659941412335;3577.874774382884;3626.601073881871;3982.7411218270718;33190.672373105044;33357.83321083403;33360.83319583387;33617.327653446795;33789.6621033789;4086.959130408717;4138.0689344897455;4182;4188.4555007849085;4213.747175169469;374812;377838;380121;380608;382472;64123.35876641174;65085;65139.67430162819;65145.67427162929;65163.67418162879;68676;68742.3125768746;68897.31102688909;68945;69006.65496672585;16511.83488165127;17274.913625431793;17277;17281.827181728273;17295.481135565955;12272.263664180178;12284.877151228553;12289.938550307192;12294.20087694297;12294.323812190416;20167.19331226764;20812.375628731163;20854.37436876896;20912.581748365254;20920.47698807542;6427.132337134521;7606.9619651901385;7632.389408847279;7722.459427839997;7869.449138560246;1003.7490627343165;1043.7442826507554;1068.8663917010374;1077.9568817247223;1129.9943050684897;32042.23245797678;32734.181645459055;32957.67042329594;33225.501617475755;33518.66481335204;1115.9944200278946;1121.8261169518737;1129.9943050684897;1193.665773583398;1206.1376116077047;17006.744898826528;17262;17424.47726568205;17449.476655591763;17498.231948442743;558830;560977;564651;564871;565152;57973.130403043986;59574;59584.40415595788;59639.40360596425;59647;1264.5510843650557;1317.1306937421448;1339.8727120923497;1355.7762969110183;1402.1096603656547;31362.372752545278;33721.3255734879;33814.66185338214;33843.66156338504;34214.315713685086;50727.2390914144;51271.48728512667;51385.48614513956;51408.74295628498;51433.22850157176;392729;396253;397522;398669;400746;37218.44172337363;37908.86273411802;38782.80608596939;38860.6113938857;42550.78724606357;46749.29876051794;47737.76131119322;48566.757166213945;48705.26942095942;49084.50915490942;37987.24025519529;40117.79941100276;41205.587944120176;41779.16441671089;42299.365509518;37838.810805946894;41019.38470922879;41416.1716765657;42005.78997104995;42177.36733949055;40649.18701625892;41561.1687766249;41659.1668166641;41832.58167418287;42119;34756.82621586876;36159;36777.63222367742;36848;36981.81509092437;27706.861465692542;28104.156875293775;28152.71847281501;28167.295817604725;28244.717552824208 14:22:10 INFO - PROCESS | 2852 | |2;jquery.html;393.83458947242156;396.68463571460694;398.509832905526;408.1164279335238;419.9811008504617;12842.288336293654;17752.112394380278;19037.809621903776;19412.90293548532;19519.316823911166;14890.18104004282;16520.83479165211;17211.569710757238;17407.477775666717;17503.82496175038;5414.377346605142;5593.188987596796;5594.49649531542;5596.356419011825;5599.132134519156;4106.691998100139;5644.6613203207735;5680.517156041721;5691.459311365435;5693.829185124453;5959.672218028007;6283.183186185813;6287.245530536319;6388.425041746242;6392.041193820917;6205.255369355661;6287.4655654269445;6331.461825744817;6346.365363463663;6366.522510811661;5586.497215250606;5604.99110160171;5624.268845050158;5638.069718496443;5649.265595472562;21252.681209781866;21484.89257553718;22181.667274990887;22193.889030554907;22503;2187.6171669957694;2242.5402792427512;2482.3173627252468;2594.455164415475;2619.4588370754195;13641.522546710818;14172.716545669133;14282.285885705776;14324.283785810772;14637.853621463755;1921.2027008791335;1962.2249211561495;2034.2371610646007;2042.4791678121983;2097.4966008158085;78089.21910780876;80715.61245481257;80891.59554202191;81057.18942810556;81139.18860811375;10024.54889529973;10051.346662466916;10203.795924081476;10302.896971030345;10337.328073675188;14435.92782036083;14492.782608260884;14637.048591841496;14673.706525869637;14674.853251467348;7591;7632.656530456032;7670.4247181461615;7727.768166955;7787.805304867424;7198.820029499305;7395.51929124616;7426;7426.257374262638;7599.848003039909;5625.409332020161;5698.544116470673;6074.817755467343;6136;6300.338464461257;1715.1510002548569;1732.488915769851;1740.1473278093642;1746.0396781769975;1770.8937463752216;991.5538007896475;996.5017491254373;1016.4085902919561;1095.7260684828793;1125.606037886733;18431.17059732315;18965.62068758645;18981.240750370107;19037.14332855025;19447.416577502696;964.5466630683568;1003.4982508745627;1009.1623952119724;1082.7888561730545;1087.7606926476162;10374.740631484123;11087.55649774;11088.279261847954;11090.722731931604;11091.83362249567;456712;456944;466604;504323;513590;81383;84012;84497;85401;86002.56998714966;1042.5777560088177;1059.1738444013681;1066.429460238784;1081.588996181446;1088.4448931045065;16372.590685232964;16603.501894943172;16937.91531042337;16974.066426346668;17122.315107395563;37646.62353376431;38247.80876095602;38721.41917871178;39421.211575768895;40193.1961360777;50306.496935031646;51271.23093153531;52068.21897671614;52942.47057529375;55024.72487637696;5246.737663116905;7128.429725622042;7851;8212.384071194803;8284.130166332448;6547.247066587403;10546.947265263625;11260.592425946757;11445.25605835618;11882.227655202385;10387.480625968823;10426.582936682447;10444.843327350247;10657.20070994663;10755.89244107549;10159.339642923187;10363.481825908826;10445.68662940113;10556.788864222826;10634.84047739269;10348.482575871327;10356.119729823049;10515.737106572396;10692.411917344309;10847.620333288298;8130.186981301823;8189.099199088215;8428.644822752984;8568.314534837322;8589.269912057545;10353.896461035594;10631.574737010433;10634.30876992993;10671.679849604525;10771.838422423512 14:22:10 INFO - PROCESS | 2852 | |3;mootools.html;1282.7498637765627;1286.2089814763917;1403.4456389726058;1421.403010735491;1824.8631352648547;8705.260052895503;9081.40970836896;9101.544922753861;9293.907060929389;9314.254859611232;8804.559772011406;9029.413088149282;9042.457452552851;9044.186023257906;9044.819103617923;2102.663573828188;2306.1006207579057;2345.9882700586472;2375.8336916415856;2376.8573885566834;2447.3147518694796;2453.2272334214754;2458.4222707663685;2458.754124587545;2460.2004348586693;2369.6208606622945;2420.5521978434044;2428.368624157714;2428.9149879754214;2430.2466235467064;2087.9373618791383;2274.749777524471;2358.433975845802;2362.9409264768346;2386.3079706884982;2284.828637852168;2307.8384513084093;2320.4662927526597;2328.5924963131383;2328.941776455585;9155.771105722344;9241.722748317561;9245.583948722324;9247.768805779842;9282.628694852197;5273.630845840793;5451.972740136274;5455.454454554513;5456.590755693299;5456.890862182734;3284.359549887773;3322.534845121685;3439.398105331582;3522.788632682047;3545.6808887200277;1097.961571345007;1122.8652561692568;1139.3961200563715;1141.7145713571608;1150.2121047082692;12978.286194259312;12996.960243180618;13018.804717929239;13037.608871733863;13090.410931508104;4727.834525791581;4837.7097374157665;4900.215965445512;4908.8772780680765;4915.606751459874;10834.945825270981;10897.128229741602;10912.618058368078;10917.508712107974;10927.781444371069;4754.667173297836;5478.068728316196;5486.039943009957;5490.505854473036;5494.230807686927;4846.80612775485;4983.401991760939;4983.6760610560195;4993.325901003391;5028.145215313405;4143.254214241466;4173.979130104391;4201.432806571135;4270.487541494978;4290.249206388869;1311.0756916373934;1330.255057167989;1342.127617048926;1348.662834291427;1366.6719987203;866.7529754020075;874.925631321332;880.2693764175718;886.3972498700946;891.3136884598823;5274.472552744694;5359.866003349947;5392.56859451243;5448.45515448452;5527.917081243784;426.6735947000547;429.95270520242747;433.6010869999608;448.618674126996;450.08183306055935;3586.7668601540818;3650.5071815305123;3655.6161603031833;3690.837386223331;3722.236941427001;10740.30188037775;10857.837132443019;11114.333140011626;11116.888831111748;11123.443827808576;11486;11644.126690498246;11750.118741094451;11770.058395328353;11772;8224.300934420522;8224.917750822415;8385.28725058377;8397.916020839835;8399.328053755808;6195.2255968004;6233.407826256498;6349.555531112777;6366.172397588284;6400.007998760199;10303.330283531546;10582.259241853304;10737.946310268399;10751;10753.354798712102;10744.409057501913;10880;10950.34297942126;10971.067459266053;11062.668119956414;7469.1037075551285;7842.764717058498;8010.639521221442;8012.719554815787;8098.3926205536;8703.56482175876;8704.825903481767;8734.213920747163;8781.868271976053;8786.560671966505;7798.6490607923915;7833.804154895945;7941.6029198541;8135.877961830695;8189.549574773445;7663.080430348394;7668.769936901902;7670.654820532978;7767.611619419119;7831.960840195762;7141.250168732416;7204.063471748639;7226.458015648742;7228.132624085143;7230.6384680766805;4930.235813448921;4997.325361076353;5059.089363914531;5145.485451454824;5168.224766285088;5019.7239151847;5027.245913113063;5081.110805609078;5161.122609156378;5166.793328266827 14:22:10 INFO - PROCESS | 2852 | |4;prototype.html;330.7833369143211;332.74544973095584;336.3894531425462;338.79841494310875;339.82159366332655;5442.319710036246;5467.910630493769;5470.316210473691;5484.232207490954;5504.174373843925;5349.438308977559;5363.570914326854;5372.683692495344;5375.865603359908;5384.542313903323;4010.418489319047;4032.8790136295956;4142.502899652046;4163.958360416387;4214.936775948363;4153.356229784373;4163.375493675958;4164.8125834337525;4183.518895327031;4188.329867221245;3972.7219094663387;4136.586341365854;4150.83396664133;4154.688398370135;4173.9582604173875;3977.4630424892557;4049.898752531181;4054.776987265714;4153.9199808049825;4157.708960372775;3660.1032746976894;3667.4132138857653;3668.1196512836996;3673.94489082664;3704.759190652599;5048.9495105048845;5119.180931051014;5141.794328226866;5155.278261043457;5167.534921857014;4593.586577208067;4744.454387745419;4760.143174228638;4790.6107228903575;4791.94577193017;5531.308586426697;5536.972315138439;5550.72246387679;5555;5570.136628822539;4044.2315959967514;4065.7967101645095;4068.2270368629866;4079.6124368184974;4082;5604.719764011783;5783.797567085174;5832.24180856486;5871.32479764824;5881.529477641779;4153.854615088458;4164.6251837334785;4164.66682665386;4178.603032711888;4184.602462766033;4255.404243405926;4256.893577660583;4258.531561528292;4264.6801489888385;4269.935950960738;4478.664100192434;4711.316859055418;4720.291956206528;4720.858374248709;4839.451375559787;5553.194786755897;5622.746976386073;5624.6625202487985;5647.350554686182;5655.416483384659;1417.9291035448186;1419.6237996930822;1430.5136253673593;1431.169921445559;1437.8993470456967;899.7390756680489;906.0169715858236;909.8817153769968;919.4115765909823;941.1388579449726;5347.465253474621;5352.892942141136;5363.517283444508;5372.7582258797665;5420.292607828522;5653.632513886584;5716.485516303553;5730.255066841284;5741.712914354265;5751.511121554631;5166.457521960216;5361.410244873061;5382.300300960928;5388.380336261302;5396.325459317585;3006.9849650752044;3007.428588568165;3021.9546706799415;3035.195673146618;3043.2087657209286;5785.247917770663;5859.94140058594;5929.436703513159;5933.258342707161;5934.240578131104;5841.182234487175;5851.853703657357;5860.179574859523;5866.560007999417;5868.207791948118;5863.560232982543;5874.383189765013;5877.089945767642;5906.852328691817;5913;5458.1266997280245;5588.720563971867;5659.236003139524;5696.401877802937;5735.569832262514;5600.943990560205;5604.243427137284;5628.690422026828;5635.323761148688;5650.547956163579;5715.971420142872;5898.3216930053595;5904.675242861512;5917.615355001911;5939.851503712442;4043.433919251366;4044;4067.1662309225944;4069.8575549855614;4081.89795255121;5680.630759000652;5701.600887937804;5712.657240565413;5715.199872017838;5749.597528173155;5405.837824865261;5566.471185237396;5598.440155984369;5600.523955463831;5609;5696.259486266758;5711.857203569944;5716.228309178207;5724.313082429969;5731.570132240182;5292.20616907467;5397.9190312144565;5511.944880551304;5570.108782594765;5598.804041858515;5714.628549144292;5733.541316694738;5742.339630942328;5744.138379243147;5759.0209664356325;5468.699221542694;5549.833504994856;5566.0499935034495;5599.60802743804;5600.243967064394 14:22:10 INFO - PROCESS | 2852 | |5;yui.html;703.6587255181237;717.4619035723207;738.9704411823527;754.4718696912156;772.694785559704;13874.236916969563;15333.769993450107;15417.15205663688;15870.761938570917;16063.036217826939;14415.711685766279;14480.927595362034;14601.561953141423;14628.780568291484;14635.121892686446;675.7601051626675;799.6921185343656;804.1917872538091;819.7499762572443;821.5768879027275;813.3980854167933;814.1573471457043;816.2857499687773;816.6733306677347;816.7019038051099;858.9012263589705;860.496609483453;861.332467337815;861.8664107063415;863.2360361080426;697.1529591546271;710.8436144048301;711.6015031582305;822.8889099971487;851.4465597361702;624.7688355308564;630.0706457974496;630.5743623054466;630.7382436288934;630.9242890853081;13468.93265533666;13508.594742157751;13524.32378381077;13538.255395953218;13584.524541641094;13662.521811736542;13690.863091369158;13748.312584370842;14248.21634810085;14438.133711977314;12447.128700990934;12568.371581420892;12636.68408289791;12745.553905613351;12877.291748953898;4317.913641727179;4354.368616550614;4423.845165419227;4489.775511224426;4578.679492435531;76663;77370.22629773687;77743;78060.21939780643;80068.99999999942;10795.514201860935;10835.133189344991;11007.779844403227;11207.327560346404;11293.322400655987;20945.37163885086;20955.68566471504;20964.580708385747;20980.580388392147;20997.895010525153;8529.317654587618;8646.740597782076;8650.52422116777;8720.12798720123;8773.122687731176;4408.713433626804;4588.26587745959;4642.257238841837;4734.171519983989;4853.830115945925;3500.632433594487;3635.5092062571744;3636.8545258189374;3638.381475149178;3640.0535860676414;508.8778693113626;593.7654626422539;605.7879742090233;606.2724730323541;606.5178183344252;544.1782907809237;581.314049421678;616.1497133955113;635.2281977397485;666.4734859460972;8923.41997770143;8945.552722363856;8961.417507861968;8999.775005624912;9173.862392064124;563.9802606908738;573.7848306884919;676.7326905872252;677.5562006885498;679.2256827216977;4104.712670113064;4383;4386.276264416336;4421.867343979686;4452.933206001912;111234.44382778196;112184;115985;116133;121549;95043.52478237565;101329;102125;102813;104238.47880760548;53515.464845351824;73283.26716732871;74426.62786686032;84736.57631711802;91295;9126.49804260772;9359.062304273955;9606.759831004001;9607.51962401863;9786.36388634765;45103.54896451125;49765.502344976085;51635;52016.73991630169;53267;50977;74268.25731742613;75743;75758.24241757512;76326;11695.298282103102;12787.552435664707;12833.86678783834;12972.221666700028;13348.199108053548;12852.807207891701;13070.738585228431;13180;13462.86537134616;13588;12871.620617575974;13484.460621575026;13728;13941.442342306194;14202.147871127765;12515.624531264077;12959.287239201558;12974.481020759064;13044.869551304366;13099.476020959055;12794.360281985677;12951.676208094874;13154.342282885626;13354.332283385986;13386.866131338562;9442.716718498456;9735.756606084904;9988.950055249968;10003.34978226413;10630.52162652667;9987.350822196535;10235.590576376862;10290.228232882713;10380.221483388927;10560.419176945034 14:22:10 INFO - PROCESS | 2852 | __end_tp_report 14:22:10 INFO - PROCESS | 2852 | __start_cc_report 14:22:10 INFO - PROCESS | 2852 | _x_x_mozilla_cycle_collect,1252 14:22:10 INFO - PROCESS | 2852 | __end_cc_report 14:22:10 INFO - PROCESS | 2852 | __startTimestamp1465248130685__endTimestamp 14:22:10 INFO - PROCESS | 2852 | 14:22:10 INFO - PROCESS | 2852 | ------- Summary: start ------- 14:22:10 INFO - PROCESS | 2852 | Number of tests: 6 14:22:10 INFO - PROCESS | 2852 | 14:22:10 INFO - PROCESS | 2852 | [#0] dojo.html Cycles:165 Average:5428.52 Median:5629.77 stddev:624.04 (11.1%) stddev-sans-first:598.66 14:22:10 INFO - PROCESS | 2852 | Values: 3101.5 3116.8 3130.3 3138.5 3173.4 5294.9 5341.7 5367.0 5453.5 5497.7 5436.9 5438.2 5455.2 5461.5 5500.0 4884.7 4958.5 4971.4 4974.5 5106.2 5032.2 5060.7 5095.6 5108.7 5115.7 4878.3 4882.0 4939.2 4960.9 4968.5 4945.7 4949.2 4957.0 4968.4 5003.4 4955.9 4974.1 4987.6 4990.7 5022.8 5248.5 5320.1 5392.6 5401.7 5480.0 5747.0 5783.4 5793.9 5795.7 5799.4 5836.3 5840.8 5847.9 5857.1 5859.5 5319.4 5422.7 5497.3 5498.1 5580.5 6050.4 6053.6 6061.9 6083.3 6094.4 5831.4 5837.8 5840.4 5842.2 5853.0 5608.2 5766.9 5833.4 5842.7 5876.8 5732.4 5753.4 5770.7 5777.2 5782.5 5673.1 5749.1 5804.7 5815.2 5817.0 4356.3 4387.0 4411.8 4436.3 4457.2 3968.1 3969.0 3969.8 3981.8 4003.5 5444.6 5582.3 5595.1 5596.9 5598.6 5836.7 5890.9 5894.9 5918.6 5952.4 5577.6 5585.9 5590.3 5590.6 5592.5 4913.3 4964.9 5069.3 5074.2 5120.2 5973.1 6013.8 6019.2 6021.2 6059.8 5873.4 5889.3 5890.6 5892.0 5893.8 5932.2 6038.3 6044.1 6070.0 6078.7 5797.9 5813.7 5814.0 5815.0 5859.2 5882.3 5885.5 5907.8 5943.1 5951.2 5534.4 5683.9 5690.7 5729.8 5771.5 5740.6 5760.1 5763.5 5765.5 5769.9 5654.0 5668.9 5670.9 5672.3 5674.8 5623.2 5629.8 5670.4 5705.8 5709.9 5541.4 5619.4 5627.1 5629.1 5637.5 14:22:10 INFO - PROCESS | 2852 | 14:22:10 INFO - PROCESS | 2852 | [#1] ext.html Cycles:180 Average:61900.77 Median:37873.84 stddev:120226.54 (317.4%) stddev-sans-first:120475.65 14:22:10 INFO - PROCESS | 2852 | Values: 581.0 607.2 620.6 621.1 637.3 30404.0 43683.6 44520.6 44652.8 44778.3 44596.6 45380.8 45388.3 45449.8 45450.0 8094.8 8705.8 8943.5 10619.8 10857.1 10242.2 10661.1 10673.6 10683.7 10686.7 10714.8 10818.3 10819.6 10838.0 10864.7 10749.8 10858.4 10865.8 10867.5 10867.6 10703.9 10791.9 10800.5 10805.4 10807.8 43719.1 44171.6 44249.0 44258.3 44345.6 3472.4 3495.3 3577.9 3626.6 3982.7 33190.7 33357.8 33360.8 33617.3 33789.7 4087.0 4138.1 4182.0 4188.5 4213.7 374812.0 377838.0 380121.0 380608.0 382472.0 64123.4 65085.0 65139.7 65145.7 65163.7 68676.0 68742.3 68897.3 68945.0 69006.7 16511.8 17274.9 17277.0 17281.8 17295.5 12272.3 12284.9 12289.9 12294.2 12294.3 20167.2 20812.4 20854.4 20912.6 20920.5 6427.1 7607.0 7632.4 7722.5 7869.4 1003.7 1043.7 1068.9 1078.0 1130.0 32042.2 32734.2 32957.7 33225.5 33518.7 1116.0 1121.8 1130.0 1193.7 1206.1 17006.7 17262.0 17424.5 17449.5 17498.2 558830.0 560977.0 564651.0 564871.0 565152.0 57973.1 59574.0 59584.4 59639.4 59647.0 1264.6 1317.1 1339.9 1355.8 1402.1 31362.4 33721.3 33814.7 33843.7 34214.3 50727.2 51271.5 51385.5 51408.7 51433.2 392729.0 396253.0 397522.0 398669.0 400746.0 37218.4 37908.9 38782.8 38860.6 42550.8 46749.3 47737.8 48566.8 48705.3 49084.5 37987.2 40117.8 41205.6 41779.2 42299.4 37838.8 41019.4 41416.2 42005.8 42177.4 40649.2 41561.2 41659.2 41832.6 42119.0 34756.8 36159.0 36777.6 36848.0 36981.8 27706.9 28104.2 28152.7 28167.3 28244.7 14:22:10 INFO - PROCESS | 2852 | 14:22:10 INFO - PROCESS | 2852 | [#2] jquery.html Cycles:180 Average:27932.55 Median:12218.21 stddev:79056.67 (647.0%) stddev-sans-first:79251.41 14:22:10 INFO - PROCESS | 2852 | Values: 393.8 396.7 398.5 408.1 420.0 12842.3 17752.1 19037.8 19412.9 19519.3 14890.2 16520.8 17211.6 17407.5 17503.8 5414.4 5593.2 5594.5 5596.4 5599.1 4106.7 5644.7 5680.5 5691.5 5693.8 5959.7 6283.2 6287.2 6388.4 6392.0 6205.3 6287.5 6331.5 6346.4 6366.5 5586.5 5605.0 5624.3 5638.1 5649.3 21252.7 21484.9 22181.7 22193.9 22503.0 2187.6 2242.5 2482.3 2594.5 2619.5 13641.5 14172.7 14282.3 14324.3 14637.9 1921.2 1962.2 2034.2 2042.5 2097.5 78089.2 80715.6 80891.6 81057.2 81139.2 10024.5 10051.3 10203.8 10302.9 10337.3 14435.9 14492.8 14637.0 14673.7 14674.9 7591.0 7632.7 7670.4 7727.8 7787.8 7198.8 7395.5 7426.0 7426.3 7599.8 5625.4 5698.5 6074.8 6136.0 6300.3 1715.2 1732.5 1740.1 1746.0 1770.9 991.6 996.5 1016.4 1095.7 1125.6 18431.2 18965.6 18981.2 19037.1 19447.4 964.5 1003.5 1009.2 1082.8 1087.8 10374.7 11087.6 11088.3 11090.7 11091.8 456712.0 456944.0 466604.0 504323.0 513590.0 81383.0 84012.0 84497.0 85401.0 86002.6 1042.6 1059.2 1066.4 1081.6 1088.4 16372.6 16603.5 16937.9 16974.1 17122.3 37646.6 38247.8 38721.4 39421.2 40193.2 50306.5 51271.2 52068.2 52942.5 55024.7 5246.7 7128.4 7851.0 8212.4 8284.1 6547.2 10546.9 11260.6 11445.3 11882.2 10387.5 10426.6 10444.8 10657.2 10755.9 10159.3 10363.5 10445.7 10556.8 10634.8 10348.5 10356.1 10515.7 10692.4 10847.6 8130.2 8189.1 8428.6 8568.3 8589.3 10353.9 10631.6 10634.3 10671.7 10771.8 14:22:10 INFO - PROCESS | 2852 | 14:22:10 INFO - PROCESS | 2852 | [#3] mootools.html Cycles:180 Average:5946.99 Median:4741.25 stddev:3508.62 (74.0%) stddev-sans-first:3500.95 14:22:10 INFO - PROCESS | 2852 | Values: 1282.7 1286.2 1403.4 1421.4 1824.9 8705.3 9081.4 9101.5 9293.9 9314.3 8804.6 9029.4 9042.5 9044.2 9044.8 2102.7 2306.1 2346.0 2375.8 2376.9 2447.3 2453.2 2458.4 2458.8 2460.2 2369.6 2420.6 2428.4 2428.9 2430.2 2087.9 2274.7 2358.4 2362.9 2386.3 2284.8 2307.8 2320.5 2328.6 2328.9 9155.8 9241.7 9245.6 9247.8 9282.6 5273.6 5452.0 5455.5 5456.6 5456.9 3284.4 3322.5 3439.4 3522.8 3545.7 1098.0 1122.9 1139.4 1141.7 1150.2 12978.3 12997.0 13018.8 13037.6 13090.4 4727.8 4837.7 4900.2 4908.9 4915.6 10834.9 10897.1 10912.6 10917.5 10927.8 4754.7 5478.1 5486.0 5490.5 5494.2 4846.8 4983.4 4983.7 4993.3 5028.1 4143.3 4174.0 4201.4 4270.5 4290.2 1311.1 1330.3 1342.1 1348.7 1366.7 866.8 874.9 880.3 886.4 891.3 5274.5 5359.9 5392.6 5448.5 5527.9 426.7 430.0 433.6 448.6 450.1 3586.8 3650.5 3655.6 3690.8 3722.2 10740.3 10857.8 11114.3 11116.9 11123.4 11486.0 11644.1 11750.1 11770.1 11772.0 8224.3 8224.9 8385.3 8397.9 8399.3 6195.2 6233.4 6349.6 6366.2 6400.0 10303.3 10582.3 10737.9 10751.0 10753.4 10744.4 10880.0 10950.3 10971.1 11062.7 7469.1 7842.8 8010.6 8012.7 8098.4 8703.6 8704.8 8734.2 8781.9 8786.6 7798.6 7833.8 7941.6 8135.9 8189.5 7663.1 7668.8 7670.7 7767.6 7832.0 7141.3 7204.1 7226.5 7228.1 7230.6 4930.2 4997.3 5059.1 5145.5 5168.2 5019.7 5027.2 5081.1 5161.1 5166.8 14:22:10 INFO - PROCESS | 2852 | 14:22:10 INFO - PROCESS | 2852 | [#4] prototype.html Cycles:180 Average:4714.52 Median:5401.88 stddev:1388.53 (25.7%) stddev-sans-first:1352.88 14:22:10 INFO - PROCESS | 2852 | Values: 330.8 332.7 336.4 338.8 339.8 5442.3 5467.9 5470.3 5484.2 5504.2 5349.4 5363.6 5372.7 5375.9 5384.5 4010.4 4032.9 4142.5 4164.0 4214.9 4153.4 4163.4 4164.8 4183.5 4188.3 3972.7 4136.6 4150.8 4154.7 4174.0 3977.5 4049.9 4054.8 4153.9 4157.7 3660.1 3667.4 3668.1 3673.9 3704.8 5048.9 5119.2 5141.8 5155.3 5167.5 4593.6 4744.5 4760.1 4790.6 4791.9 5531.3 5537.0 5550.7 5555.0 5570.1 4044.2 4065.8 4068.2 4079.6 4082.0 5604.7 5783.8 5832.2 5871.3 5881.5 4153.9 4164.6 4164.7 4178.6 4184.6 4255.4 4256.9 4258.5 4264.7 4269.9 4478.7 4711.3 4720.3 4720.9 4839.5 5553.2 5622.7 5624.7 5647.4 5655.4 1417.9 1419.6 1430.5 1431.2 1437.9 899.7 906.0 909.9 919.4 941.1 5347.5 5352.9 5363.5 5372.8 5420.3 5653.6 5716.5 5730.3 5741.7 5751.5 5166.5 5361.4 5382.3 5388.4 5396.3 3007.0 3007.4 3022.0 3035.2 3043.2 5785.2 5859.9 5929.4 5933.3 5934.2 5841.2 5851.9 5860.2 5866.6 5868.2 5863.6 5874.4 5877.1 5906.9 5913.0 5458.1 5588.7 5659.2 5696.4 5735.6 5600.9 5604.2 5628.7 5635.3 5650.5 5716.0 5898.3 5904.7 5917.6 5939.9 4043.4 4044.0 4067.2 4069.9 4081.9 5680.6 5701.6 5712.7 5715.2 5749.6 5405.8 5566.5 5598.4 5600.5 5609.0 5696.3 5711.9 5716.2 5724.3 5731.6 5292.2 5397.9 5511.9 5570.1 5598.8 5714.6 5733.5 5742.3 5744.1 5759.0 5468.7 5549.8 5566.0 5599.6 5600.2 14:22:10 INFO - PROCESS | 2852 | 14:22:10 INFO - PROCESS | 2852 | [#5] yui.html Cycles:180 Average:20262.38 Median:24841.11 stddev:29565.61 (119.0%) stddev-sans-first:29612.08 14:22:10 INFO - PROCESS | 2852 | Values: 703.7 717.5 739.0 754.5 772.7 13874.2 15333.8 15417.2 15870.8 16063.0 14415.7 14480.9 14601.6 14628.8 14635.1 675.8 799.7 804.2 819.7 821.6 813.4 814.2 816.3 816.7 816.7 858.9 860.5 861.3 861.9 863.2 697.2 710.8 711.6 822.9 851.4 624.8 630.1 630.6 630.7 630.9 13468.9 13508.6 13524.3 13538.3 13584.5 13662.5 13690.9 13748.3 14248.2 14438.1 12447.1 12568.4 12636.7 12745.6 12877.3 4317.9 4354.4 4423.8 4489.8 4578.7 76663.0 77370.2 77743.0 78060.2 80069.0 10795.5 10835.1 11007.8 11207.3 11293.3 20945.4 20955.7 20964.6 20980.6 20997.9 8529.3 8646.7 8650.5 8720.1 8773.1 4408.7 4588.3 4642.3 4734.2 4853.8 3500.6 3635.5 3636.9 3638.4 3640.1 508.9 593.8 605.8 606.3 606.5 544.2 581.3 616.1 635.2 666.5 8923.4 8945.6 8961.4 8999.8 9173.9 564.0 573.8 676.7 677.6 679.2 4104.7 4383.0 4386.3 4421.9 4452.9 111234.4 112184.0 115985.0 116133.0 121549.0 95043.5 101329.0 102125.0 102813.0 104238.5 53515.5 73283.3 74426.6 84736.6 91295.0 9126.5 9359.1 9606.8 9607.5 9786.4 45103.5 49765.5 51635.0 52016.7 53267.0 50977.0 74268.3 75743.0 75758.2 76326.0 11695.3 12787.6 12833.9 12972.2 13348.2 12852.8 13070.7 13180.0 13462.9 13588.0 12871.6 13484.5 13728.0 13941.4 14202.1 12515.6 12959.3 12974.5 13044.9 13099.5 12794.4 12951.7 13154.3 13354.3 13386.9 9442.7 9735.8 9989.0 10003.3 10630.5 9987.4 10235.6 10290.2 10380.2 10560.4 14:22:10 INFO - PROCESS | 2852 | -------- Summary: end -------- 14:22:10 INFO - PROCESS | 2852 | 14:22:11 INFO - TEST-INFO | 2852: exit 0 14:22:11 INFO - TEST-OK | dromaeo_css | took 1114360ms 14:22:11 INFO - TEST-START | kraken 14:22:11 INFO - operating with platform_type : linux_ 14:22:11 INFO - Initialising browser for kraken test... 14:22:11 INFO - TEST-INFO | started process 3059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe4laDj/profile http://localhost:45374/getInfo.html) 14:22:15 INFO - PROCESS | 3059 | __metrics Screen width/height:1600/1200 14:22:15 INFO - PROCESS | 3059 | colorDepth:24 14:22:15 INFO - PROCESS | 3059 | Browser inner width/height: 1024/697 14:22:15 INFO - PROCESS | 3059 | __metrics 14:22:16 ERROR - PROCESS | 3059 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:22:16 INFO - PROCESS | 3059 | console.error: PushService: 14:22:16 INFO - PROCESS | 3059 | stateChangeProcessEnqueue: Error transitioning state 14:22:16 INFO - PROCESS | 3059 | UnknownError 14:22:17 INFO - TEST-INFO | 3059: exit 0 14:22:17 INFO - Browser initialized. 14:22:17 INFO - Running cycle 1/1 for kraken test... 14:22:17 INFO - TEST-INFO | started process 3143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe4laDj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:29 INFO - PROCESS | 3143 | RSS: Main: 156409856 14:22:29 INFO - PROCESS | 3143 | 14:22:31 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45374/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:32 INFO - PROCESS | 3143 | RSS: Main: 214376448 14:22:32 INFO - PROCESS | 3143 | 14:22:35 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45374/tests/kraken/driver.html?testName=audio-dft) 14:22:36 INFO - PROCESS | 3143 | RSS: Main: 201695232 14:22:36 INFO - PROCESS | 3143 | 14:22:39 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45374/tests/kraken/driver.html?testName=audio-fft) 14:22:39 INFO - PROCESS | 3143 | RSS: Main: 269111296 14:22:39 INFO - PROCESS | 3143 | 14:22:42 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45374/tests/kraken/driver.html?testName=audio-oscillator) 14:22:42 INFO - PROCESS | 3143 | RSS: Main: 179789824 14:22:42 INFO - PROCESS | 3143 | 14:22:44 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:45 INFO - PROCESS | 3143 | RSS: Main: 183758848 14:22:45 INFO - PROCESS | 3143 | 14:22:48 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45374/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:48 INFO - PROCESS | 3143 | RSS: Main: 220368896 14:22:48 INFO - PROCESS | 3143 | 14:22:52 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45374/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:52 INFO - PROCESS | 3143 | RSS: Main: 221319168 14:22:52 INFO - PROCESS | 3143 | 14:22:55 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45374/tests/kraken/driver.html?testName=json-parse-financial) 14:22:56 INFO - PROCESS | 3143 | RSS: Main: 220651520 14:22:56 INFO - PROCESS | 3143 | 14:22:57 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:58 INFO - PROCESS | 3143 | RSS: Main: 205668352 14:22:58 INFO - PROCESS | 3143 | 14:23:00 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45374/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:23:00 INFO - PROCESS | 3143 | RSS: Main: 210370560 14:23:00 INFO - PROCESS | 3143 | 14:23:02 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:23:03 INFO - PROCESS | 3143 | RSS: Main: 217489408 14:23:03 INFO - PROCESS | 3143 | 14:23:06 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:23:06 INFO - PROCESS | 3143 | RSS: Main: 223424512 14:23:06 INFO - PROCESS | 3143 | 14:23:09 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:23:09 INFO - PROCESS | 3143 | RSS: Main: 223617024 14:23:09 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | Cycle 1(1): loaded http://localhost:45374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45374/tests/kraken/driver.html?testName=ai-astar) 14:23:11 INFO - PROCESS | 3143 | RSS: Main: 265695232 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | __start_tp_report 14:23:11 INFO - PROCESS | 3143 | _x_x_mozilla_page_load 14:23:11 INFO - PROCESS | 3143 | _x_x_mozilla_page_load_details 14:23:11 INFO - PROCESS | 3143 | |i|pagename|runs| 14:23:11 INFO - PROCESS | 3143 | |0;ai-astar;111;106;110;112;111;111;111;110;112;111 14:23:11 INFO - PROCESS | 3143 | |1;audio-beat-detection;156;127;126;177;124;125;163;129;191;129 14:23:11 INFO - PROCESS | 3143 | |2;audio-dft;160;160;162;161;162;162;163;162;161;160 14:23:11 INFO - PROCESS | 3143 | |3;audio-fft;75;75;76;115;75;77;73;74;99;74 14:23:11 INFO - PROCESS | 3143 | |4;audio-oscillator;84;86;113;85;84;85;126;85;85;117 14:23:11 INFO - PROCESS | 3143 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;119 14:23:11 INFO - PROCESS | 3143 | |6;imaging-darkroom;150;151;149;148;151;148;149;148;148;156 14:23:11 INFO - PROCESS | 3143 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 14:23:11 INFO - PROCESS | 3143 | |8;json-parse-financial;53;51;51;52;53;52;51;53;51;53 14:23:11 INFO - PROCESS | 3143 | |9;json-stringify-tinderbox;62;64;63;63;63;64;64;63;64;64 14:23:11 INFO - PROCESS | 3143 | |10;stanford-crypto-aes;77;79;78;79;86;79;84;79;109;81 14:23:11 INFO - PROCESS | 3143 | |11;stanford-crypto-ccm;120;123;119;121;118;118;126;120;121;144 14:23:11 INFO - PROCESS | 3143 | |12;stanford-crypto-pbkdf2;165;162;158;162;165;159;161;161;162;158 14:23:11 INFO - PROCESS | 3143 | |13;stanford-crypto-sha256-iterative;62;62;63;62;62;62;70;62;62;64 14:23:11 INFO - PROCESS | 3143 | __end_tp_report 14:23:11 INFO - PROCESS | 3143 | __start_cc_report 14:23:11 INFO - PROCESS | 3143 | _x_x_mozilla_cycle_collect,1627 14:23:11 INFO - PROCESS | 3143 | __end_cc_report 14:23:11 INFO - PROCESS | 3143 | __startTimestamp1465248191888__endTimestamp 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | ------- Summary: start ------- 14:23:11 INFO - PROCESS | 3143 | Number of tests: 14 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.72 (1.5%) stddev-sans-first:1.81 14:23:11 INFO - PROCESS | 3143 | Values: 111.0 106.0 110.0 112.0 111.0 111.0 111.0 110.0 112.0 111.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:142.50 stddev:24.99 (17.5%) stddev-sans-first:26.17 14:23:11 INFO - PROCESS | 3143 | Values: 156.0 127.0 126.0 177.0 124.0 125.0 163.0 129.0 191.0 129.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 14:23:11 INFO - PROCESS | 3143 | Values: 160.0 160.0 162.0 161.0 162.0 162.0 163.0 162.0 161.0 160.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:14.10 (18.8%) stddev-sans-first:14.77 14:23:11 INFO - PROCESS | 3143 | Values: 75.0 75.0 76.0 115.0 75.0 77.0 73.0 74.0 99.0 74.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:85.00 stddev:16.64 (19.6%) stddev-sans-first:17.17 14:23:11 INFO - PROCESS | 3143 | Values: 84.0 86.0 113.0 85.0 84.0 85.0 126.0 85.0 85.0 117.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 14:23:11 INFO - PROCESS | 3143 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 119.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:149.50 stddev:2.49 (1.7%) stddev-sans-first:2.64 14:23:11 INFO - PROCESS | 3143 | Values: 150.0 151.0 149.0 148.0 151.0 148.0 149.0 148.0 148.0 156.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:23:11 INFO - PROCESS | 3143 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.50 stddev:0.94 (1.8%) stddev-sans-first:0.93 14:23:11 INFO - PROCESS | 3143 | Values: 53.0 51.0 51.0 52.0 53.0 52.0 51.0 53.0 51.0 53.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 14:23:11 INFO - PROCESS | 3143 | Values: 62.0 64.0 63.0 63.0 63.0 64.0 64.0 63.0 64.0 64.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:79.00 stddev:9.52 (12.0%) stddev-sans-first:9.83 14:23:11 INFO - PROCESS | 3143 | Values: 77.0 79.0 78.0 79.0 86.0 79.0 84.0 79.0 109.0 81.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:121.00 stddev:7.76 (6.4%) stddev-sans-first:8.15 14:23:11 INFO - PROCESS | 3143 | Values: 120.0 123.0 119.0 121.0 118.0 118.0 126.0 120.0 121.0 144.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:162.00 stddev:2.50 (1.5%) stddev-sans-first:2.26 14:23:11 INFO - PROCESS | 3143 | Values: 165.0 162.0 158.0 162.0 165.0 159.0 161.0 161.0 162.0 158.0 14:23:11 INFO - PROCESS | 3143 | 14:23:11 INFO - PROCESS | 3143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:62.00 stddev:2.51 (4.1%) stddev-sans-first:2.64 14:23:11 INFO - PROCESS | 3143 | Values: 62.0 62.0 63.0 62.0 62.0 62.0 70.0 62.0 62.0 64.0 14:23:11 INFO - PROCESS | 3143 | -------- Summary: end -------- 14:23:11 INFO - PROCESS | 3143 | 14:23:12 INFO - TEST-INFO | 3143: exit 0 14:23:12 INFO - TEST-OK | kraken | took 61474ms 14:23:12 INFO - SUITE-END | took 1175s 14:23:13 INFO - Completed test suite (00:19:36) 14:23:13 INFO - javascript benchmark 14:23:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.534769784532, 3116.766242531811, 3130.34262804811, 3138.5135304027885, 3173.3970545596335, 5294.947050529494, 5341.679499230044, 5366.973165134169, 5453.5364494018, 5497.697626630534, 5436.891262174754, 5438.238646589481, 5455.236266922634, 5461.5357694595905, 5499.972500137504, 4884.682495637781, 4958.479359667237, 4971.37857767779, 4974.527419895104, 5106.183010718286, 5032.220005899091, 5060.746962651852, 5095.6178286628465, 5108.667936584129, 5115.718635475047, 4878.292647566101, 4881.951180488185, 4939.234418665113, 4960.925586116211, 4968.453470118284, 4945.703257804544, 4949.208126699711, 4956.975215123901, 4968.428630707479, 5003.424606170301, 4955.925661115086, 4974.129527332702, 4987.551120399182, 4990.675606085629, 5022.84931452057, 5248.527632513054, 5320.095583750772, 5392.595555333366, 5401.7299135043095, 5480.04099282624, 5746.9712651436475, 5783.363829978699, 5793.855153621151, 5795.681237531934, 5799.420057994209, 5836.270466191726, 5840.766369345221, 5847.853803654943, 5857.062869940789, 5859.472647461749, 5319.3616765987945, 5422.728863556807, 5497.257870187514, 5498.092814685572, 5580.469855363734, 6050.3599984088605, 6053.599370122627, 6061.932595448327, 6083.300420451616, 6094.360092190344, 5831.358550559435, 5837.824865254049, 5840.3575606683235, 5842.2405087338375, 5852.970735146297, 5608.158776183605, 5766.94233057664, 5833.445822646841, 5842.737076831553, 5876.764929402776, 5732.398098199712, 5753.367129615739, 5770.653760774367, 5777.2200752897825, 5782.479576838105, 5673.149027645886, 5749.051406517878, 5804.6807425592, 5815.156802263648, 5817.0, 4356.259435895905, 4386.978065109654, 4411.801468933906, 4436.3123715824095, 4457.175422546839, 3968.1270120573427, 3969.047428617169, 3969.7816620086173, 3981.820818063194, 4003.499562554681, 5444.564434845203, 5582.330120385498, 5595.132754423071, 5596.86007849807, 5598.552115830724, 5836.67898265591, 5890.9410905891245, 5894.882102358015, 5918.556108291896, 5952.375000624958, 5577.581681373913, 5585.916211256835, 5590.301212348457, 5590.636608620427, 5592.5246354059545, 4913.287573301851, 4964.90070198594, 5069.340985671913, 5074.162763144113, 5120.206368012964, 5973.104034394789, 6013.759449622054, 6019.247594050744, 6021.217241758543, 6059.848503787441, 5873.442023007893, 5889.263842019747, 5890.587658863838, 5892.0, 5893.793717220048, 5932.1694962706115, 6038.275406951194, 6044.063170208625, 6070.0, 6078.665673388006, 5797.8550536236935, 5813.680247586423, 5813.970930145322, 5814.970925145347, 5859.179714840011, 5882.323532793784, 5885.529157667462, 5907.793227237026, 5943.138244954371, 5951.16683664296, 5534.418886017072, 5683.914741278967, 5690.743916523849, 5729.828105156852, 5771.538276937751, 5740.598158128891, 5760.107183386414, 5763.4812866842185, 5765.538756899354, 5769.913451298318, 5654.038813401649, 5668.886622267449, 5670.914936275876, 5672.290963629546, 5674.77300907959, 5623.2408624835125, 5629.774809007594, 5670.432956704297, 5705.828825135252, 5709.942900571107, 5541.362743284574, 5619.381867994435, 5627.071533196977, 5629.099344104923, 5637.52081073097], "value": 5385.633015125372, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.9941900580993, 607.1772747926559, 620.6493331267833, 621.0963048764046, 637.3435361577576, 30404.0, 43683.563164368345, 44520.554794452044, 44652.77673611636, 44778.32832507515, 44596.554034459725, 45380.77309613456, 45388.3191752124, 45449.77275113628, 45450.0, 8094.838103237932, 8705.825883482326, 8943.50810705411, 10619.84070238947, 10857.131429485662, 10242.180625549976, 10661.147108231324, 10673.626423075193, 10683.732906677318, 10686.732831679192, 10714.839277410845, 10818.296810707317, 10819.621313254038, 10838.0, 10864.728381790439, 10749.83875241872, 10858.402787846666, 10865.83701244482, 10867.51096200665, 10867.619633312876, 10703.892961070367, 10791.892081079246, 10800.51397687106, 10805.351678899291, 10807.837882431691, 43719.12561748779, 44171.558284417064, 44249.0, 44258.33612495815, 44345.55654443479, 3472.3576138414473, 3495.2659941412335, 3577.874774382884, 3626.601073881871, 3982.7411218270718, 33190.672373105044, 33357.83321083403, 33360.83319583387, 33617.327653446795, 33789.6621033789, 4086.959130408717, 4138.0689344897455, 4182.0, 4188.4555007849085, 4213.747175169469, 374812.0, 377838.0, 380121.0, 380608.0, 382472.0, 64123.35876641174, 65085.0, 65139.67430162819, 65145.67427162929, 65163.67418162879, 68676.0, 68742.3125768746, 68897.31102688909, 68945.0, 69006.65496672585, 16511.83488165127, 17274.913625431793, 17277.0, 17281.827181728273, 17295.481135565955, 12272.263664180178, 12284.877151228553, 12289.938550307192, 12294.20087694297, 12294.323812190416, 20167.19331226764, 20812.375628731163, 20854.37436876896, 20912.581748365254, 20920.47698807542, 6427.132337134521, 7606.9619651901385, 7632.389408847279, 7722.459427839997, 7869.449138560246, 1003.7490627343165, 1043.7442826507554, 1068.8663917010374, 1077.9568817247223, 1129.9943050684897, 32042.23245797678, 32734.181645459055, 32957.67042329594, 33225.501617475755, 33518.66481335204, 1115.9944200278946, 1121.8261169518737, 1129.9943050684897, 1193.665773583398, 1206.1376116077047, 17006.744898826528, 17262.0, 17424.47726568205, 17449.476655591763, 17498.231948442743, 558830.0, 560977.0, 564651.0, 564871.0, 565152.0, 57973.130403043986, 59574.0, 59584.40415595788, 59639.40360596425, 59647.0, 1264.5510843650557, 1317.1306937421448, 1339.8727120923497, 1355.7762969110183, 1402.1096603656547, 31362.372752545278, 33721.3255734879, 33814.66185338214, 33843.66156338504, 34214.315713685086, 50727.2390914144, 51271.48728512667, 51385.48614513956, 51408.74295628498, 51433.22850157176, 392729.0, 396253.0, 397522.0, 398669.0, 400746.0, 37218.44172337363, 37908.86273411802, 38782.80608596939, 38860.6113938857, 42550.78724606357, 46749.29876051794, 47737.76131119322, 48566.757166213945, 48705.26942095942, 49084.50915490942, 37987.24025519529, 40117.79941100276, 41205.587944120176, 41779.16441671089, 42299.365509518, 37838.810805946894, 41019.38470922879, 41416.1716765657, 42005.78997104995, 42177.36733949055, 40649.18701625892, 41561.1687766249, 41659.1668166641, 41832.58167418287, 42119.0, 34756.82621586876, 36159.0, 36777.63222367742, 36848.0, 36981.81509092437, 27706.861465692542, 28104.156875293775, 28152.71847281501, 28167.295817604725, 28244.717552824208], "value": 21142.22667810011, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.83458947242156, 396.68463571460694, 398.509832905526, 408.1164279335238, 419.9811008504617, 12842.288336293654, 17752.112394380278, 19037.809621903776, 19412.90293548532, 19519.316823911166, 14890.18104004282, 16520.83479165211, 17211.569710757238, 17407.477775666717, 17503.82496175038, 5414.377346605142, 5593.188987596796, 5594.49649531542, 5596.356419011825, 5599.132134519156, 4106.691998100139, 5644.6613203207735, 5680.517156041721, 5691.459311365435, 5693.829185124453, 5959.672218028007, 6283.183186185813, 6287.245530536319, 6388.425041746242, 6392.041193820917, 6205.255369355661, 6287.4655654269445, 6331.461825744817, 6346.365363463663, 6366.522510811661, 5586.497215250606, 5604.99110160171, 5624.268845050158, 5638.069718496443, 5649.265595472562, 21252.681209781866, 21484.89257553718, 22181.667274990887, 22193.889030554907, 22503.0, 2187.6171669957694, 2242.5402792427512, 2482.3173627252468, 2594.455164415475, 2619.4588370754195, 13641.522546710818, 14172.716545669133, 14282.285885705776, 14324.283785810772, 14637.853621463755, 1921.2027008791335, 1962.2249211561495, 2034.2371610646007, 2042.4791678121983, 2097.4966008158085, 78089.21910780876, 80715.61245481257, 80891.59554202191, 81057.18942810556, 81139.18860811375, 10024.54889529973, 10051.346662466916, 10203.795924081476, 10302.896971030345, 10337.328073675188, 14435.92782036083, 14492.782608260884, 14637.048591841496, 14673.706525869637, 14674.853251467348, 7591.0, 7632.656530456032, 7670.4247181461615, 7727.768166955, 7787.805304867424, 7198.820029499305, 7395.51929124616, 7426.0, 7426.257374262638, 7599.848003039909, 5625.409332020161, 5698.544116470673, 6074.817755467343, 6136.0, 6300.338464461257, 1715.1510002548569, 1732.488915769851, 1740.1473278093642, 1746.0396781769975, 1770.8937463752216, 991.5538007896475, 996.5017491254373, 1016.4085902919561, 1095.7260684828793, 1125.606037886733, 18431.17059732315, 18965.62068758645, 18981.240750370107, 19037.14332855025, 19447.416577502696, 964.5466630683568, 1003.4982508745627, 1009.1623952119724, 1082.7888561730545, 1087.7606926476162, 10374.740631484123, 11087.55649774, 11088.279261847954, 11090.722731931604, 11091.83362249567, 456712.0, 456944.0, 466604.0, 504323.0, 513590.0, 81383.0, 84012.0, 84497.0, 85401.0, 86002.56998714966, 1042.5777560088177, 1059.1738444013681, 1066.429460238784, 1081.588996181446, 1088.4448931045065, 16372.590685232964, 16603.501894943172, 16937.91531042337, 16974.066426346668, 17122.315107395563, 37646.62353376431, 38247.80876095602, 38721.41917871178, 39421.211575768895, 40193.1961360777, 50306.496935031646, 51271.23093153531, 52068.21897671614, 52942.47057529375, 55024.72487637696, 5246.737663116905, 7128.429725622042, 7851.0, 8212.384071194803, 8284.130166332448, 6547.247066587403, 10546.947265263625, 11260.592425946757, 11445.25605835618, 11882.227655202385, 10387.480625968823, 10426.582936682447, 10444.843327350247, 10657.20070994663, 10755.89244107549, 10159.339642923187, 10363.481825908826, 10445.68662940113, 10556.788864222826, 10634.84047739269, 10348.482575871327, 10356.119729823049, 10515.737106572396, 10692.411917344309, 10847.620333288298, 8130.186981301823, 8189.099199088215, 8428.644822752984, 8568.314534837322, 8589.269912057545, 10353.896461035594, 10631.574737010433, 10634.30876992993, 10671.679849604525, 10771.838422423512], "value": 8993.86791251566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.7498637765627, 1286.2089814763917, 1403.4456389726058, 1421.403010735491, 1824.8631352648547, 8705.260052895503, 9081.40970836896, 9101.544922753861, 9293.907060929389, 9314.254859611232, 8804.559772011406, 9029.413088149282, 9042.457452552851, 9044.186023257906, 9044.819103617923, 2102.663573828188, 2306.1006207579057, 2345.9882700586472, 2375.8336916415856, 2376.8573885566834, 2447.3147518694796, 2453.2272334214754, 2458.4222707663685, 2458.754124587545, 2460.2004348586693, 2369.6208606622945, 2420.5521978434044, 2428.368624157714, 2428.9149879754214, 2430.2466235467064, 2087.9373618791383, 2274.749777524471, 2358.433975845802, 2362.9409264768346, 2386.3079706884982, 2284.828637852168, 2307.8384513084093, 2320.4662927526597, 2328.5924963131383, 2328.941776455585, 9155.771105722344, 9241.722748317561, 9245.583948722324, 9247.768805779842, 9282.628694852197, 5273.630845840793, 5451.972740136274, 5455.454454554513, 5456.590755693299, 5456.890862182734, 3284.359549887773, 3322.534845121685, 3439.398105331582, 3522.788632682047, 3545.6808887200277, 1097.961571345007, 1122.8652561692568, 1139.3961200563715, 1141.7145713571608, 1150.2121047082692, 12978.286194259312, 12996.960243180618, 13018.804717929239, 13037.608871733863, 13090.410931508104, 4727.834525791581, 4837.7097374157665, 4900.215965445512, 4908.8772780680765, 4915.606751459874, 10834.945825270981, 10897.128229741602, 10912.618058368078, 10917.508712107974, 10927.781444371069, 4754.667173297836, 5478.068728316196, 5486.039943009957, 5490.505854473036, 5494.230807686927, 4846.80612775485, 4983.401991760939, 4983.6760610560195, 4993.325901003391, 5028.145215313405, 4143.254214241466, 4173.979130104391, 4201.432806571135, 4270.487541494978, 4290.249206388869, 1311.0756916373934, 1330.255057167989, 1342.127617048926, 1348.662834291427, 1366.6719987203, 866.7529754020075, 874.925631321332, 880.2693764175718, 886.3972498700946, 891.3136884598823, 5274.472552744694, 5359.866003349947, 5392.56859451243, 5448.45515448452, 5527.917081243784, 426.6735947000547, 429.95270520242747, 433.6010869999608, 448.618674126996, 450.08183306055935, 3586.7668601540818, 3650.5071815305123, 3655.6161603031833, 3690.837386223331, 3722.236941427001, 10740.30188037775, 10857.837132443019, 11114.333140011626, 11116.888831111748, 11123.443827808576, 11486.0, 11644.126690498246, 11750.118741094451, 11770.058395328353, 11772.0, 8224.300934420522, 8224.917750822415, 8385.28725058377, 8397.916020839835, 8399.328053755808, 6195.2255968004, 6233.407826256498, 6349.555531112777, 6366.172397588284, 6400.007998760199, 10303.330283531546, 10582.259241853304, 10737.946310268399, 10751.0, 10753.354798712102, 10744.409057501913, 10880.0, 10950.34297942126, 10971.067459266053, 11062.668119956414, 7469.1037075551285, 7842.764717058498, 8010.639521221442, 8012.719554815787, 8098.3926205536, 8703.56482175876, 8704.825903481767, 8734.213920747163, 8781.868271976053, 8786.560671966505, 7798.6490607923915, 7833.804154895945, 7941.6029198541, 8135.877961830695, 8189.549574773445, 7663.080430348394, 7668.769936901902, 7670.654820532978, 7767.611619419119, 7831.960840195762, 7141.250168732416, 7204.063471748639, 7226.458015648742, 7228.132624085143, 7230.6384680766805, 4930.235813448921, 4997.325361076353, 5059.089363914531, 5145.485451454824, 5168.224766285088, 5019.7239151847, 5027.245913113063, 5081.110805609078, 5161.122609156378, 5166.793328266827], "value": 4614.2859055487215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.7833369143211, 332.74544973095584, 336.3894531425462, 338.79841494310875, 339.82159366332655, 5442.319710036246, 5467.910630493769, 5470.316210473691, 5484.232207490954, 5504.174373843925, 5349.438308977559, 5363.570914326854, 5372.683692495344, 5375.865603359908, 5384.542313903323, 4010.418489319047, 4032.8790136295956, 4142.502899652046, 4163.958360416387, 4214.936775948363, 4153.356229784373, 4163.375493675958, 4164.8125834337525, 4183.518895327031, 4188.329867221245, 3972.7219094663387, 4136.586341365854, 4150.83396664133, 4154.688398370135, 4173.9582604173875, 3977.4630424892557, 4049.898752531181, 4054.776987265714, 4153.9199808049825, 4157.708960372775, 3660.1032746976894, 3667.4132138857653, 3668.1196512836996, 3673.94489082664, 3704.759190652599, 5048.9495105048845, 5119.180931051014, 5141.794328226866, 5155.278261043457, 5167.534921857014, 4593.586577208067, 4744.454387745419, 4760.143174228638, 4790.6107228903575, 4791.94577193017, 5531.308586426697, 5536.972315138439, 5550.72246387679, 5555.0, 5570.136628822539, 4044.2315959967514, 4065.7967101645095, 4068.2270368629866, 4079.6124368184974, 4082.0, 5604.719764011783, 5783.797567085174, 5832.24180856486, 5871.32479764824, 5881.529477641779, 4153.854615088458, 4164.6251837334785, 4164.66682665386, 4178.603032711888, 4184.602462766033, 4255.404243405926, 4256.893577660583, 4258.531561528292, 4264.6801489888385, 4269.935950960738, 4478.664100192434, 4711.316859055418, 4720.291956206528, 4720.858374248709, 4839.451375559787, 5553.194786755897, 5622.746976386073, 5624.6625202487985, 5647.350554686182, 5655.416483384659, 1417.9291035448186, 1419.6237996930822, 1430.5136253673593, 1431.169921445559, 1437.8993470456967, 899.7390756680489, 906.0169715858236, 909.8817153769968, 919.4115765909823, 941.1388579449726, 5347.465253474621, 5352.892942141136, 5363.517283444508, 5372.7582258797665, 5420.292607828522, 5653.632513886584, 5716.485516303553, 5730.255066841284, 5741.712914354265, 5751.511121554631, 5166.457521960216, 5361.410244873061, 5382.300300960928, 5388.380336261302, 5396.325459317585, 3006.9849650752044, 3007.428588568165, 3021.9546706799415, 3035.195673146618, 3043.2087657209286, 5785.247917770663, 5859.94140058594, 5929.436703513159, 5933.258342707161, 5934.240578131104, 5841.182234487175, 5851.853703657357, 5860.179574859523, 5866.560007999417, 5868.207791948118, 5863.560232982543, 5874.383189765013, 5877.089945767642, 5906.852328691817, 5913.0, 5458.1266997280245, 5588.720563971867, 5659.236003139524, 5696.401877802937, 5735.569832262514, 5600.943990560205, 5604.243427137284, 5628.690422026828, 5635.323761148688, 5650.547956163579, 5715.971420142872, 5898.3216930053595, 5904.675242861512, 5917.615355001911, 5939.851503712442, 4043.433919251366, 4044.0, 4067.1662309225944, 4069.8575549855614, 4081.89795255121, 5680.630759000652, 5701.600887937804, 5712.657240565413, 5715.199872017838, 5749.597528173155, 5405.837824865261, 5566.471185237396, 5598.440155984369, 5600.523955463831, 5609.0, 5696.259486266758, 5711.857203569944, 5716.228309178207, 5724.313082429969, 5731.570132240182, 5292.20616907467, 5397.9190312144565, 5511.944880551304, 5570.108782594765, 5598.804041858515, 5714.628549144292, 5733.541316694738, 5742.339630942328, 5744.138379243147, 5759.0209664356325, 5468.699221542694, 5549.833504994856, 5566.0499935034495, 5599.60802743804, 5600.243967064394], "value": 4268.715771447798, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.6587255181237, 717.4619035723207, 738.9704411823527, 754.4718696912156, 772.694785559704, 13874.236916969563, 15333.769993450107, 15417.15205663688, 15870.761938570917, 16063.036217826939, 14415.711685766279, 14480.927595362034, 14601.561953141423, 14628.780568291484, 14635.121892686446, 675.7601051626675, 799.6921185343656, 804.1917872538091, 819.7499762572443, 821.5768879027275, 813.3980854167933, 814.1573471457043, 816.2857499687773, 816.6733306677347, 816.7019038051099, 858.9012263589705, 860.496609483453, 861.332467337815, 861.8664107063415, 863.2360361080426, 697.1529591546271, 710.8436144048301, 711.6015031582305, 822.8889099971487, 851.4465597361702, 624.7688355308564, 630.0706457974496, 630.5743623054466, 630.7382436288934, 630.9242890853081, 13468.93265533666, 13508.594742157751, 13524.32378381077, 13538.255395953218, 13584.524541641094, 13662.521811736542, 13690.863091369158, 13748.312584370842, 14248.21634810085, 14438.133711977314, 12447.128700990934, 12568.371581420892, 12636.68408289791, 12745.553905613351, 12877.291748953898, 4317.913641727179, 4354.368616550614, 4423.845165419227, 4489.775511224426, 4578.679492435531, 76663.0, 77370.22629773687, 77743.0, 78060.21939780643, 80068.99999999942, 10795.514201860935, 10835.133189344991, 11007.779844403227, 11207.327560346404, 11293.322400655987, 20945.37163885086, 20955.68566471504, 20964.580708385747, 20980.580388392147, 20997.895010525153, 8529.317654587618, 8646.740597782076, 8650.52422116777, 8720.12798720123, 8773.122687731176, 4408.713433626804, 4588.26587745959, 4642.257238841837, 4734.171519983989, 4853.830115945925, 3500.632433594487, 3635.5092062571744, 3636.8545258189374, 3638.381475149178, 3640.0535860676414, 508.8778693113626, 593.7654626422539, 605.7879742090233, 606.2724730323541, 606.5178183344252, 544.1782907809237, 581.314049421678, 616.1497133955113, 635.2281977397485, 666.4734859460972, 8923.41997770143, 8945.552722363856, 8961.417507861968, 8999.775005624912, 9173.862392064124, 563.9802606908738, 573.7848306884919, 676.7326905872252, 677.5562006885498, 679.2256827216977, 4104.712670113064, 4383.0, 4386.276264416336, 4421.867343979686, 4452.933206001912, 111234.44382778196, 112184.0, 115985.0, 116133.0, 121549.0, 95043.52478237565, 101329.0, 102125.0, 102813.0, 104238.47880760548, 53515.464845351824, 73283.26716732871, 74426.62786686032, 84736.57631711802, 91295.0, 9126.49804260772, 9359.062304273955, 9606.759831004001, 9607.51962401863, 9786.36388634765, 45103.54896451125, 49765.502344976085, 51635.0, 52016.73991630169, 53267.0, 50977.0, 74268.25731742613, 75743.0, 75758.24241757512, 76326.0, 11695.298282103102, 12787.552435664707, 12833.86678783834, 12972.221666700028, 13348.199108053548, 12852.807207891701, 13070.738585228431, 13180.0, 13462.86537134616, 13588.0, 12871.620617575974, 13484.460621575026, 13728.0, 13941.442342306194, 14202.147871127765, 12515.624531264077, 12959.287239201558, 12974.481020759064, 13044.869551304366, 13099.476020959055, 12794.360281985677, 12951.676208094874, 13154.342282885626, 13354.332283385986, 13386.866131338562, 9442.716718498456, 9735.756606084904, 9988.950055249968, 10003.34978226413, 10630.52162652667, 9987.350822196535, 10235.590576376862, 10290.228232882713, 10380.221483388927, 10560.419176945034], "value": 7311.452458180221, "unit": "score"}], "name": "dromaeo_css", "value": 7268.825937343636, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 112.0, 111.0, 111.0, 111.0, 110.0, 112.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 126.0, 177.0, 124.0, 125.0, 163.0, 129.0, 191.0, 129.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 162.0, 162.0, 163.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 115.0, 75.0, 77.0, 73.0, 74.0, 99.0, 74.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 113.0, 85.0, 84.0, 85.0, 126.0, 85.0, 85.0, 117.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 119.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 149.0, 148.0, 151.0, 148.0, 149.0, 148.0, 148.0, 156.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 52.0, 53.0, 52.0, 51.0, 53.0, 51.0, 53.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 78.0, 79.0, 86.0, 79.0, 84.0, 79.0, 109.0, 81.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 123.0, 119.0, 121.0, 118.0, 118.0, 126.0, 120.0, 121.0, 144.0], "value": 123.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 158.0, 162.0, 165.0, 159.0, 161.0, 161.0, 162.0, 158.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 70.0, 62.0, 62.0, 64.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1500.4999999999998, "alertThreshold": 2.0}]} 14:23:13 INFO - Return code: 0 14:23:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:23:13 ERROR - # TBPL SUCCESS # 14:23:13 INFO - Running post-action listener: _resource_record_post_action 14:23:13 INFO - ##### 14:23:13 INFO - ##### Finished run-tests step (success) 14:23:13 INFO - ##### 14:23:13 INFO - Running post-run listener: _resource_record_post_run 14:23:13 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 541069312; Read time: 268; Write time: 602000 14:23:13 INFO - TinderboxPrint: CPU usage
13.2% 14:23:13 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 268 14:23:13 INFO - TinderboxPrint: I/O write bytes / time
541,069,312 / 602,000 14:23:13 INFO - TinderboxPrint: CPU idle
8,274.3 (86.8%) 14:23:13 INFO - TinderboxPrint: CPU user
1,208.3 (12.7%) 14:23:13 INFO - TinderboxPrint: Swap in / out
0 / 0 14:23:13 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248205312; Read time: 0; Write time: 293304 14:23:13 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292597760; Read time: 268; Write time: 308656 14:23:13 INFO - Running post-run listener: _upload_blobber_files 14:23:13 INFO - Blob upload gear active. 14:23:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:23:13 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 14:23:13 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:23:13 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:23:14 INFO - (blobuploader) - INFO - Open directory for files ... 14:23:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:23:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:23:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:18 INFO - (blobuploader) - INFO - Done attempting. 14:23:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:23:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:23:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:19 INFO - (blobuploader) - INFO - Done attempting. 14:23:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:23:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:23:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:19 INFO - (blobuploader) - INFO - Done attempting. 14:23:19 INFO - (blobuploader) - INFO - Iteration through files over. 14:23:19 INFO - Return code: 0 14:23:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:23:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:23:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3231f6131f95c098fdf4203eddcec73be269dd8a351d0bf0ecf4309c0853078f3ecf32c11788532ddb0815ca2be4089885205b4b5de01f8fffd0246cb559c2de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77902ee7381dc9e33be4481998466f94eca2fc3645b6e5145eef9beaae3da98e0d1cac4dbd869984c834406535e1baac3f1f9d4b6379d31aa2e1e6bc6c7357cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/844909fe24f43c9c41a0759df442b2f1aaf72611da5e131deeaade12f1642f73caba6e9da37f26d1016e3b92b0b43352a207112f11897cbacaa5b5536a98489a"} 14:23:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:23:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:23:19 INFO - Contents: 14:23:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3231f6131f95c098fdf4203eddcec73be269dd8a351d0bf0ecf4309c0853078f3ecf32c11788532ddb0815ca2be4089885205b4b5de01f8fffd0246cb559c2de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77902ee7381dc9e33be4481998466f94eca2fc3645b6e5145eef9beaae3da98e0d1cac4dbd869984c834406535e1baac3f1f9d4b6379d31aa2e1e6bc6c7357cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/844909fe24f43c9c41a0759df442b2f1aaf72611da5e131deeaade12f1642f73caba6e9da37f26d1016e3b92b0b43352a207112f11897cbacaa5b5536a98489a"} 14:23:19 INFO - Running post-run listener: copy_logs_to_upload_dir 14:23:19 INFO - Copying logs to upload dir... 14:23:19 INFO - mkdir: /builds/slave/test/build/upload/logs 14:23:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.364388 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-06 14:23:19.724753) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 14:23:19.727899) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3231f6131f95c098fdf4203eddcec73be269dd8a351d0bf0ecf4309c0853078f3ecf32c11788532ddb0815ca2be4089885205b4b5de01f8fffd0246cb559c2de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77902ee7381dc9e33be4481998466f94eca2fc3645b6e5145eef9beaae3da98e0d1cac4dbd869984c834406535e1baac3f1f9d4b6379d31aa2e1e6bc6c7357cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/844909fe24f43c9c41a0759df442b2f1aaf72611da5e131deeaade12f1642f73caba6e9da37f26d1016e3b92b0b43352a207112f11897cbacaa5b5536a98489a"} build_url:https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3231f6131f95c098fdf4203eddcec73be269dd8a351d0bf0ecf4309c0853078f3ecf32c11788532ddb0815ca2be4089885205b4b5de01f8fffd0246cb559c2de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77902ee7381dc9e33be4481998466f94eca2fc3645b6e5145eef9beaae3da98e0d1cac4dbd869984c834406535e1baac3f1f9d4b6379d31aa2e1e6bc6c7357cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/844909fe24f43c9c41a0759df442b2f1aaf72611da5e131deeaade12f1642f73caba6e9da37f26d1016e3b92b0b43352a207112f11897cbacaa5b5536a98489a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 14:23:19.752631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:23:19.752937) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465245598.556704-1605537501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004747 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:23:19.835371) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 14:23:19.835711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 14:23:19.836016) ========= ========= Total master_lag: 0.14 =========