builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1466754399.28 results: success (0) buildid: 20160624001256 builduid: 03a6e2d342444e16be567425d66bec06 revision: 085b95afe6e38af8f920454caf9bdbb6db50afec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:39.280623) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:39.281174) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:39.281508) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:39.365120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:39.365415) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 00:46:40-- 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% 78.3M=0s 2016-06-24 00:46:40 (78.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121714 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:39.506477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:39.507199) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019749 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:39.559862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:39.560241) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 085b95afe6e38af8f920454caf9bdbb6db50afec --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 085b95afe6e38af8f920454caf9bdbb6db50afec --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=97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 00:46:40,588 truncating revision to first 12 chars 2016-06-24 00:46:40,588 Setting DEBUG logging. 2016-06-24 00:46:40,588 attempt 1/10 2016-06-24 00:46:40,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/085b95afe6e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 00:46:40,873 unpacking tar archive at: fx-team-085b95afe6e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:40.254363) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:40.254740) ========= script_repo_revision: 085b95afe6e38af8f920454caf9bdbb6db50afec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:40.255240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:40.255563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 00:46:40.265675) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-24 00:46:40.266008) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:46:41 INFO - MultiFileLogger online at 20160624 00:46:41 in /builds/slave/test 00:46:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:46:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:46:41 INFO - {'append_to_log': False, 00:46:41 INFO - 'base_work_dir': '/builds/slave/test', 00:46:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:46:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:46:41 INFO - 'branch': 'Fx-Team-Non-PGO', 00:46:41 INFO - 'buildbot_json_path': 'buildprops.json', 00:46:41 INFO - 'config_files': ('talos/linux_config.py',), 00:46:41 INFO - 'default_actions': ('clobber', 00:46:41 INFO - 'read-buildbot-config', 00:46:41 INFO - 'download-and-extract', 00:46:41 INFO - 'populate-webroot', 00:46:41 INFO - 'create-virtualenv', 00:46:41 INFO - 'install', 00:46:41 INFO - 'run-tests'), 00:46:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:46:41 INFO - 'download_minidump_stackwalk': True, 00:46:41 INFO - 'download_symbols': 'ondemand', 00:46:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:46:41 INFO - 'tooltool.py': '/tools/tooltool.py', 00:46:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:46:41 INFO - '/tools/misc-python/virtualenv.py')}, 00:46:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:46:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:46:41 INFO - 'installer_path': 'installer.exe', 00:46:41 INFO - 'log_level': 'info', 00:46:41 INFO - 'log_name': 'talos', 00:46:41 INFO - 'log_to_console': True, 00:46:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:46:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:46:41 INFO - 'opt_config_files': (), 00:46:41 INFO - 'pip_index': False, 00:46:41 INFO - 'sps_profile': False, 00:46:41 INFO - 'sps_profile_interval': 0, 00:46:41 INFO - 'suite': 'dromaeojs', 00:46:41 INFO - 'system_bits': '32', 00:46:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:46:41 INFO - 'title': 'talos-linux64-ix-068', 00:46:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:46:41 INFO - 'use_talos_json': True, 00:46:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:46:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:46:41 INFO - 'work_dir': 'build'} 00:46:41 INFO - ##### 00:46:41 INFO - ##### Running clobber step. 00:46:41 INFO - ##### 00:46:41 INFO - Running pre-action listener: _resource_record_pre_action 00:46:41 INFO - Running main action method: clobber 00:46:41 INFO - rmtree: /builds/slave/test/build 00:46:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:46:41 INFO - Running post-action listener: _resource_record_post_action 00:46:41 INFO - ##### 00:46:41 INFO - ##### Finished clobber step (success) 00:46:41 INFO - ##### 00:46:41 INFO - ##### 00:46:41 INFO - ##### Running read-buildbot-config step. 00:46:41 INFO - ##### 00:46:41 INFO - Running pre-action listener: _resource_record_pre_action 00:46:41 INFO - Running main action method: read_buildbot_config 00:46:41 INFO - Using buildbot properties: 00:46:41 INFO - { 00:46:41 INFO - "project": "", 00:46:41 INFO - "product": "firefox", 00:46:41 INFO - "script_repo_revision": "production", 00:46:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:46:41 INFO - "repository": "", 00:46:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:46:41 INFO - "buildid": "20160624001256", 00:46:41 INFO - "pgo_build": "False", 00:46:41 INFO - "basedir": "/builds/slave/test", 00:46:41 INFO - "buildnumber": 3111, 00:46:41 INFO - "slavename": "talos-linux64-ix-068", 00:46:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:46:41 INFO - "platform": "ubuntu64_hw", 00:46:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:46:41 INFO - "branch": "fx-team", 00:46:41 INFO - "repo_path": "integration/fx-team", 00:46:41 INFO - "revision": "085b95afe6e38af8f920454caf9bdbb6db50afec", 00:46:41 INFO - "stage_platform": "linux64", 00:46:41 INFO - "builduid": "03a6e2d342444e16be567425d66bec06", 00:46:41 INFO - "slavebuilddir": "test" 00:46:41 INFO - } 00:46:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:46:41 INFO - Running post-action listener: _resource_record_post_action 00:46:41 INFO - ##### 00:46:41 INFO - ##### Finished read-buildbot-config step (success) 00:46:41 INFO - ##### 00:46:41 INFO - ##### 00:46:41 INFO - ##### Running download-and-extract step. 00:46:41 INFO - ##### 00:46:41 INFO - Running pre-action listener: _resource_record_pre_action 00:46:41 INFO - Running main action method: download_and_extract 00:46:41 INFO - mkdir: /builds/slave/test/build/tests 00:46:41 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')]} 00:46:41 INFO - https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:46:42 INFO - Downloaded 1361 bytes. 00:46:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:46:42 INFO - Using the following test package requirements: 00:46:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:46:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:46:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:46:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:46:42 INFO - u'jsshell-linux-x86_64.zip'], 00:46:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:46:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:46:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:46:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:46:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:46:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:46:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:46:42 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')]} 00:46:42 INFO - https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:46:43 INFO - Downloaded 22709646 bytes. 00:46:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:46:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:46:44 INFO - Return code: 0 00:46:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:46:44 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')]} 00:46:44 INFO - https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:46:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:46:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:46:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:46:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:46:52 INFO - Downloaded 22709646 bytes. 00:46:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:46:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:46:53 INFO - Return code: 0 00:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:46:53 INFO - https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:46:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:46:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:46:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:46:54 INFO - Downloaded 14405384 bytes. 00:46:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:46:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:46:54 INFO - Return code: 0 00:46:54 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')]} 00:46:54 INFO - https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:46:56 INFO - Downloaded 56259555 bytes. 00:46:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:46:56 INFO - mkdir: /builds/slave/test/properties 00:46:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:46:56 INFO - Writing to file /builds/slave/test/properties/build_url 00:46:56 INFO - Contents: 00:46:56 INFO - build_url:https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:46:56 INFO - Running post-action listener: _resource_record_post_action 00:46:56 INFO - Running post-action listener: set_extra_try_arguments 00:46:56 INFO - ##### 00:46:56 INFO - ##### Finished download-and-extract step (success) 00:46:56 INFO - ##### 00:46:56 INFO - ##### 00:46:56 INFO - ##### Running populate-webroot step. 00:46:56 INFO - ##### 00:46:56 INFO - Running pre-action listener: _resource_record_pre_action 00:46:56 INFO - Running main action method: populate_webroot 00:46:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:46:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:46:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:46:56 INFO - '--tppagecycles', 00:46:56 INFO - '7'], 00:46:56 INFO - 'tests': ['tsvgm']}}, 00:46:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:46:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:46:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:46:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:46:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:46:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:46:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:46:56 INFO - 'talos_options': ['--disable-e10s'], 00:46:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:46:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:46:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:46:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:46:56 INFO - 'talos_options': ['--disable-e10s'], 00:46:56 INFO - 'tests': ['damp', 'tps']}, 00:46:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:46:56 INFO - 'tests': ['damp', 'tps']}, 00:46:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:46:56 INFO - 'tests': ['dromaeo_dom']}, 00:46:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:46:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:46:56 INFO - 'tests': ['basic_compositor_video']}, 00:46:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:46:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:46:56 INFO - 'tests': ['a11yr', 00:46:56 INFO - 'ts_paint', 00:46:56 INFO - 'tpaint', 00:46:56 INFO - 'sessionrestore', 00:46:56 INFO - 'sessionrestore_no_auto_restore', 00:46:56 INFO - 'tabpaint']}, 00:46:56 INFO - 'other-e10s': {'tests': ['a11yr', 00:46:56 INFO - 'ts_paint', 00:46:56 INFO - 'tpaint', 00:46:56 INFO - 'sessionrestore', 00:46:56 INFO - 'sessionrestore_no_auto_restore', 00:46:56 INFO - 'tabpaint']}, 00:46:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:46:56 INFO - 'ts_paint', 00:46:56 INFO - 'tpaint', 00:46:56 INFO - 'sessionrestore', 00:46:56 INFO - 'sessionrestore_no_auto_restore', 00:46:56 INFO - 'tabpaint']}, 00:46:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:46:56 INFO - 'ts_paint', 00:46:56 INFO - 'tpaint', 00:46:56 INFO - 'sessionrestore', 00:46:56 INFO - 'sessionrestore_no_auto_restore', 00:46:56 INFO - 'tabpaint']}, 00:46:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:46:56 INFO - 'tests': ['a11yr', 00:46:56 INFO - 'ts_paint', 00:46:57 INFO - 'tpaint', 00:46:57 INFO - 'sessionrestore', 00:46:57 INFO - 'sessionrestore_no_auto_restore', 00:46:57 INFO - 'tabpaint']}, 00:46:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:46:57 INFO - 'tests': ['a11yr', 00:46:57 INFO - 'ts_paint', 00:46:57 INFO - 'tpaint', 00:46:57 INFO - 'sessionrestore', 00:46:57 INFO - 'sessionrestore_no_auto_restore', 00:46:57 INFO - 'tabpaint']}, 00:46:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:46:57 INFO - 'tests': ['tsvgx', 00:46:57 INFO - 'tsvgr_opacity', 00:46:57 INFO - 'tart', 00:46:57 INFO - 'tscrollx', 00:46:57 INFO - 'cart']}, 00:46:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:46:57 INFO - 'tsvgr_opacity', 00:46:57 INFO - 'tart', 00:46:57 INFO - 'tscrollx', 00:46:57 INFO - 'cart']}, 00:46:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:46:57 INFO - 'talos_options': ['--disable-e10s'], 00:46:57 INFO - 'tests': ['tp5o']}, 00:46:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:46:57 INFO - 'tests': ['tp5o']}, 00:46:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:46:57 INFO - 'talos_options': ['--disable-e10s', 00:46:57 INFO - '--xperf_path', 00:46:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:46:57 INFO - 'tests': ['tp5n']}, 00:46:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:46:57 INFO - 'talos_options': ['--xperf_path', 00:46:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:46:57 INFO - 'tests': ['tp5n']}}, 00:46:57 INFO - 'talos.zip': {'path': '', 00:46:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:46:57 INFO - Running post-action listener: _resource_record_post_action 00:46:57 INFO - ##### 00:46:57 INFO - ##### Finished populate-webroot step (success) 00:46:57 INFO - ##### 00:46:57 INFO - ##### 00:46:57 INFO - ##### Running create-virtualenv step. 00:46:57 INFO - ##### 00:46:57 INFO - Running pre-action listener: _resource_record_pre_action 00:46:57 INFO - Running main action method: create_virtualenv 00:46:57 INFO - Creating virtualenv /builds/slave/test/build/venv 00:46:57 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 00:46:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:46:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:46:57 INFO - Using real prefix '/usr' 00:46:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:46:57 INFO - Installing distribute.............................................................................................................................................................................................done. 00:46:59 INFO - Installing pip.................done. 00:46:59 INFO - Return code: 0 00:46:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:46: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')]} 00:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:46: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')]} 00:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:46:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8ec61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', '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 00:46:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:46:59 INFO - Using env: {'DISPLAY': ':0', 00:46:59 INFO - 'HOME': '/home/cltbld', 00:46:59 INFO - 'LANG': 'en_US.UTF-8', 00:46:59 INFO - 'LANGUAGE': 'en_US:en', 00:46:59 INFO - 'LOGNAME': 'cltbld', 00:46:59 INFO - 'MAIL': '/var/mail/cltbld', 00:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:46:59 INFO - 'MOZ_NO_REMOTE': '1', 00:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:46:59 INFO - 'NO_EM_RESTART': '1', 00:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:46:59 INFO - 'PWD': '/builds/slave/test', 00:46:59 INFO - 'SHELL': '/bin/bash', 00:46:59 INFO - 'SHLVL': '1', 00:46:59 INFO - 'TERM': 'linux', 00:46:59 INFO - 'TMOUT': '86400', 00:46:59 INFO - 'USER': 'cltbld', 00:46:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:46:59 INFO - '_': '/tools/buildbot/bin/python'} 00:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:46:59 INFO - Cleaning up... 00:46:59 INFO - Return code: 0 00:46:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:46: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')]} 00:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:46: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')]} 00:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:46:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8ec61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', '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 00:46:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:46:59 INFO - Using env: {'DISPLAY': ':0', 00:46:59 INFO - 'HOME': '/home/cltbld', 00:46:59 INFO - 'LANG': 'en_US.UTF-8', 00:46:59 INFO - 'LANGUAGE': 'en_US:en', 00:46:59 INFO - 'LOGNAME': 'cltbld', 00:46:59 INFO - 'MAIL': '/var/mail/cltbld', 00:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:46:59 INFO - 'MOZ_NO_REMOTE': '1', 00:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:46:59 INFO - 'NO_EM_RESTART': '1', 00:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:46:59 INFO - 'PWD': '/builds/slave/test', 00:46:59 INFO - 'SHELL': '/bin/bash', 00:46:59 INFO - 'SHLVL': '1', 00:46:59 INFO - 'TERM': 'linux', 00:46:59 INFO - 'TMOUT': '86400', 00:46:59 INFO - 'USER': 'cltbld', 00:46:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:46:59 INFO - '_': '/tools/buildbot/bin/python'} 00:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:00 INFO - Downloading/unpacking psutil>=3.1.1 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:47:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:47:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:47:02 INFO - Installing collected packages: psutil 00:47:02 INFO - Running setup.py install for psutil 00:47:02 INFO - building 'psutil._psutil_linux' extension 00:47:02 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 00:47:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:47:02 INFO - building 'psutil._psutil_posix' extension 00:47:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:47:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:47:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:47:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:47:02 INFO - Successfully installed psutil 00:47:02 INFO - Cleaning up... 00:47:02 INFO - Return code: 0 00:47:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:47: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')]} 00:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47: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')]} 00:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8ec61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', '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 00:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:47:02 INFO - Using env: {'DISPLAY': ':0', 00:47:02 INFO - 'HOME': '/home/cltbld', 00:47:02 INFO - 'LANG': 'en_US.UTF-8', 00:47:02 INFO - 'LANGUAGE': 'en_US:en', 00:47:02 INFO - 'LOGNAME': 'cltbld', 00:47:02 INFO - 'MAIL': '/var/mail/cltbld', 00:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:02 INFO - 'MOZ_NO_REMOTE': '1', 00:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:02 INFO - 'NO_EM_RESTART': '1', 00:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:02 INFO - 'PWD': '/builds/slave/test', 00:47:02 INFO - 'SHELL': '/bin/bash', 00:47:02 INFO - 'SHLVL': '1', 00:47:02 INFO - 'TERM': 'linux', 00:47:02 INFO - 'TMOUT': '86400', 00:47:02 INFO - 'USER': 'cltbld', 00:47:02 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:02 INFO - '_': '/tools/buildbot/bin/python'} 00:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:47:04 INFO - Installing collected packages: mozsystemmonitor 00:47:04 INFO - Running setup.py install for mozsystemmonitor 00:47:04 INFO - Successfully installed mozsystemmonitor 00:47:04 INFO - Cleaning up... 00:47:04 INFO - Return code: 0 00:47:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:47: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')]} 00:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47: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')]} 00:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8ec61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', '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 00:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:47:04 INFO - Using env: {'DISPLAY': ':0', 00:47:04 INFO - 'HOME': '/home/cltbld', 00:47:04 INFO - 'LANG': 'en_US.UTF-8', 00:47:04 INFO - 'LANGUAGE': 'en_US:en', 00:47:04 INFO - 'LOGNAME': 'cltbld', 00:47:04 INFO - 'MAIL': '/var/mail/cltbld', 00:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:04 INFO - 'MOZ_NO_REMOTE': '1', 00:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:04 INFO - 'NO_EM_RESTART': '1', 00:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:04 INFO - 'PWD': '/builds/slave/test', 00:47:04 INFO - 'SHELL': '/bin/bash', 00:47:04 INFO - 'SHLVL': '1', 00:47:04 INFO - 'TERM': 'linux', 00:47:04 INFO - 'TMOUT': '86400', 00:47:04 INFO - 'USER': 'cltbld', 00:47:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:04 INFO - '_': '/tools/buildbot/bin/python'} 00:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:05 INFO - Downloading/unpacking jsonschema==2.5.1 00:47:05 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 00:47:05 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 00:47:05 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 00:47:05 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 00:47:05 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 00:47:05 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 00:47:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:47:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47:07 INFO - Downloading functools32-3.2.3-2.tar.gz 00:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:47:07 INFO - warning: no files found matching '*.txt' 00:47:07 INFO - no previously-included directories found matching 'build' 00:47:07 INFO - no previously-included directories found matching 'dist' 00:47:07 INFO - no previously-included directories found matching '.git*' 00:47:07 INFO - Installing collected packages: jsonschema, functools32 00:47:07 INFO - Running setup.py install for functools32 00:47:07 INFO - warning: no files found matching '*.txt' 00:47:07 INFO - no previously-included directories found matching 'build' 00:47:07 INFO - no previously-included directories found matching 'dist' 00:47:07 INFO - no previously-included directories found matching '.git*' 00:47:07 INFO - Successfully installed jsonschema functools32 00:47:07 INFO - Cleaning up... 00:47:07 INFO - Return code: 0 00:47:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8ec61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', '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 00:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:47:07 INFO - Using env: {'DISPLAY': ':0', 00:47:07 INFO - 'HOME': '/home/cltbld', 00:47:07 INFO - 'LANG': 'en_US.UTF-8', 00:47:07 INFO - 'LANGUAGE': 'en_US:en', 00:47:07 INFO - 'LOGNAME': 'cltbld', 00:47:07 INFO - 'MAIL': '/var/mail/cltbld', 00:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:07 INFO - 'MOZ_NO_REMOTE': '1', 00:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:07 INFO - 'NO_EM_RESTART': '1', 00:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:07 INFO - 'PWD': '/builds/slave/test', 00:47:07 INFO - 'SHELL': '/bin/bash', 00:47:07 INFO - 'SHLVL': '1', 00:47:07 INFO - 'TERM': 'linux', 00:47:07 INFO - 'TMOUT': '86400', 00:47:07 INFO - 'USER': 'cltbld', 00:47:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:07 INFO - '_': '/tools/buildbot/bin/python'} 00:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:07 INFO - Downloading/unpacking blobuploader==1.2.4 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47:09 INFO - Downloading blobuploader-1.2.4.tar.gz 00:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:47:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:47:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:10 INFO - Downloading docopt-0.6.1.tar.gz 00:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:47:10 INFO - Installing collected packages: blobuploader, requests, docopt 00:47:10 INFO - Running setup.py install for blobuploader 00:47:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:47:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:47:10 INFO - Running setup.py install for requests 00:47:11 INFO - Running setup.py install for docopt 00:47:11 INFO - Successfully installed blobuploader requests docopt 00:47:11 INFO - Cleaning up... 00:47:11 INFO - Return code: 0 00:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:47: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')]} 00:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47: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')]} 00:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:11 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 0x7fd8ec61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', '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 00:47:11 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 00:47:11 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 00:47:11 INFO - Using env: {'DISPLAY': ':0', 00:47:11 INFO - 'HOME': '/home/cltbld', 00:47:11 INFO - 'LANG': 'en_US.UTF-8', 00:47:11 INFO - 'LANGUAGE': 'en_US:en', 00:47:11 INFO - 'LOGNAME': 'cltbld', 00:47:11 INFO - 'MAIL': '/var/mail/cltbld', 00:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:11 INFO - 'MOZ_NO_REMOTE': '1', 00:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:11 INFO - 'NO_EM_RESTART': '1', 00:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:11 INFO - 'PWD': '/builds/slave/test', 00:47:11 INFO - 'SHELL': '/bin/bash', 00:47:11 INFO - 'SHLVL': '1', 00:47:11 INFO - 'TERM': 'linux', 00:47:11 INFO - 'TMOUT': '86400', 00:47:11 INFO - 'USER': 'cltbld', 00:47:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:11 INFO - '_': '/tools/buildbot/bin/python'} 00:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:47:11 INFO - Running setup.py (path:/tmp/pip-RHlC5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:47:11 INFO - Running setup.py (path:/tmp/pip-qaJcZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:47:11 INFO - Running setup.py (path:/tmp/pip-_Y1JZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:47:11 INFO - Running setup.py (path:/tmp/pip-UiIWOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:47:11 INFO - Running setup.py (path:/tmp/pip-raR_rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:47:11 INFO - Running setup.py (path:/tmp/pip-rPBIUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:47:11 INFO - Running setup.py (path:/tmp/pip-CEiOdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:47:11 INFO - Running setup.py (path:/tmp/pip-YaODWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:47:12 INFO - Running setup.py (path:/tmp/pip-M9ocDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:47:12 INFO - Running setup.py (path:/tmp/pip-7qNIi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:47:12 INFO - Running setup.py (path:/tmp/pip-YZwK1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:47:12 INFO - Running setup.py (path:/tmp/pip-DSCa5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:47:12 INFO - Running setup.py (path:/tmp/pip-PFSOc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:47:12 INFO - Running setup.py (path:/tmp/pip-l_ycNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:47:12 INFO - Running setup.py (path:/tmp/pip-y0v7fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:47:12 INFO - Running setup.py (path:/tmp/pip-eClPRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:47:12 INFO - Running setup.py (path:/tmp/pip-EdU1sX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:47:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:47:12 INFO - Running setup.py install for manifestparser 00:47:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:47:12 INFO - Running setup.py install for mozcrash 00:47:12 INFO - Running setup.py install for mozdebug 00:47:12 INFO - Running setup.py install for mozdevice 00:47:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:47:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:47:13 INFO - Running setup.py install for mozfile 00:47:13 INFO - Running setup.py install for mozhttpd 00:47:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:47:13 INFO - Running setup.py install for mozinfo 00:47:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:47:13 INFO - Running setup.py install for mozInstall 00:47:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:47:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:47:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:47:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:47:13 INFO - Running setup.py install for mozleak 00:47:13 INFO - Running setup.py install for mozlog 00:47:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:47:13 INFO - Running setup.py install for moznetwork 00:47:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:47:13 INFO - Running setup.py install for mozprocess 00:47:13 INFO - Running setup.py install for mozprofile 00:47:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:47:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:47:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:47:14 INFO - Running setup.py install for mozrunner 00:47:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:47:14 INFO - Running setup.py install for mozscreenshot 00:47:14 INFO - Running setup.py install for moztest 00:47:14 INFO - Running setup.py install for mozversion 00:47:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:47:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:47:14 INFO - Cleaning up... 00:47:14 INFO - Return code: 0 00:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:47:14 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')]} 00:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:14 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')]} 00:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:14 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 0x7fd8ec61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', '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 00:47:14 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 00:47:14 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 00:47:14 INFO - Using env: {'DISPLAY': ':0', 00:47:14 INFO - 'HOME': '/home/cltbld', 00:47:14 INFO - 'LANG': 'en_US.UTF-8', 00:47:14 INFO - 'LANGUAGE': 'en_US:en', 00:47:14 INFO - 'LOGNAME': 'cltbld', 00:47:14 INFO - 'MAIL': '/var/mail/cltbld', 00:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:14 INFO - 'MOZ_NO_REMOTE': '1', 00:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:14 INFO - 'NO_EM_RESTART': '1', 00:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:14 INFO - 'PWD': '/builds/slave/test', 00:47:14 INFO - 'SHELL': '/bin/bash', 00:47:14 INFO - 'SHLVL': '1', 00:47:14 INFO - 'TERM': 'linux', 00:47:14 INFO - 'TMOUT': '86400', 00:47:14 INFO - 'USER': 'cltbld', 00:47:14 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:14 INFO - '_': '/tools/buildbot/bin/python'} 00:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:47:14 INFO - Running setup.py (path:/tmp/pip-1iQvOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:47:14 INFO - Running setup.py (path:/tmp/pip-TESNrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:47:14 INFO - Running setup.py (path:/tmp/pip-T3EOEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:47:14 INFO - Running setup.py (path:/tmp/pip-2qf5HS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:47:15 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)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:47:15 INFO - Running setup.py (path:/tmp/pip-tAyo6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:47:15 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)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:47:15 INFO - Running setup.py (path:/tmp/pip-hULfRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:47:15 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)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:47:15 INFO - Running setup.py (path:/tmp/pip-FrUd25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:47:15 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)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:47:15 INFO - Running setup.py (path:/tmp/pip-r64M2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:47:15 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)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:47:15 INFO - Running setup.py (path:/tmp/pip-0NSrWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:47:15 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)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:47:15 INFO - Running setup.py (path:/tmp/pip-2Z80tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:47:15 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)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:47:15 INFO - Running setup.py (path:/tmp/pip-pTyJqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:47:15 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)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:47:15 INFO - Running setup.py (path:/tmp/pip-ifMdWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:47:15 INFO - Running setup.py (path:/tmp/pip-Y824Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:47:15 INFO - Running setup.py (path:/tmp/pip-2vhSy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:47:15 INFO - Running setup.py (path:/tmp/pip-bjqQmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:47:15 INFO - Running setup.py (path:/tmp/pip-cQhmEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:47:15 INFO - Running setup.py (path:/tmp/pip-Zh92P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:47:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47:17 INFO - Downloading blessings-1.6.tar.gz 00:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:47:17 INFO - Installing collected packages: blessings 00:47:17 INFO - Running setup.py install for blessings 00:47:18 INFO - Successfully installed blessings 00:47:18 INFO - Cleaning up... 00:47:18 INFO - Return code: 0 00:47:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:47:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:47:18 INFO - Reading from file tmpfile_stdout 00:47:18 INFO - Current package versions: 00:47:18 INFO - argparse == 1.2.1 00:47:18 INFO - blessings == 1.6 00:47:18 INFO - blobuploader == 1.2.4 00:47:18 INFO - docopt == 0.6.1 00:47:18 INFO - functools32 == 3.2.3-2 00:47:18 INFO - jsonschema == 2.5.1 00:47:18 INFO - manifestparser == 1.1 00:47:18 INFO - mozInstall == 1.12 00:47:18 INFO - mozcrash == 0.17 00:47:18 INFO - mozdebug == 0.1 00:47:18 INFO - mozdevice == 0.48 00:47:18 INFO - mozfile == 1.2 00:47:18 INFO - mozhttpd == 0.7 00:47:18 INFO - mozinfo == 0.9 00:47:18 INFO - mozleak == 0.1 00:47:18 INFO - mozlog == 3.2 00:47:18 INFO - moznetwork == 0.27 00:47:18 INFO - mozprocess == 0.22 00:47:18 INFO - mozprofile == 0.28 00:47:18 INFO - mozrunner == 6.11 00:47:18 INFO - mozscreenshot == 0.1 00:47:18 INFO - mozsystemmonitor == 0.3 00:47:18 INFO - moztest == 0.7 00:47:18 INFO - mozversion == 1.4 00:47:18 INFO - psutil == 3.1.1 00:47:18 INFO - requests == 1.2.3 00:47:18 INFO - wsgiref == 0.1.2 00:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:18 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 0x7fd8ec61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', '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 00:47:18 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 00:47:18 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 00:47:18 INFO - Using env: {'DISPLAY': ':0', 00:47:18 INFO - 'HOME': '/home/cltbld', 00:47:18 INFO - 'LANG': 'en_US.UTF-8', 00:47:18 INFO - 'LANGUAGE': 'en_US:en', 00:47:18 INFO - 'LOGNAME': 'cltbld', 00:47:18 INFO - 'MAIL': '/var/mail/cltbld', 00:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:18 INFO - 'MOZ_NO_REMOTE': '1', 00:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:18 INFO - 'NO_EM_RESTART': '1', 00:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:18 INFO - 'PWD': '/builds/slave/test', 00:47:18 INFO - 'SHELL': '/bin/bash', 00:47:18 INFO - 'SHLVL': '1', 00:47:18 INFO - 'TERM': 'linux', 00:47:18 INFO - 'TMOUT': '86400', 00:47:18 INFO - 'USER': 'cltbld', 00:47:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:18 INFO - '_': '/tools/buildbot/bin/python'} 00:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:18 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)) 00:47:18 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)) 00:47:18 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)) 00:47:18 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)) 00:47:18 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)) 00:47:18 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)) 00:47:18 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)) 00:47:18 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)) 00:47:18 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)) 00:47:18 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)) 00:47:18 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)) 00:47:18 INFO - Cleaning up... 00:47:18 INFO - Return code: 0 00:47:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8ec61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', '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 00:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:47:18 INFO - Using env: {'DISPLAY': ':0', 00:47:18 INFO - 'HOME': '/home/cltbld', 00:47:18 INFO - 'LANG': 'en_US.UTF-8', 00:47:18 INFO - 'LANGUAGE': 'en_US:en', 00:47:18 INFO - 'LOGNAME': 'cltbld', 00:47:18 INFO - 'MAIL': '/var/mail/cltbld', 00:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:18 INFO - 'MOZ_NO_REMOTE': '1', 00:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:18 INFO - 'NO_EM_RESTART': '1', 00:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:18 INFO - 'PWD': '/builds/slave/test', 00:47:18 INFO - 'SHELL': '/bin/bash', 00:47:18 INFO - 'SHLVL': '1', 00:47:18 INFO - 'TERM': 'linux', 00:47:18 INFO - 'TMOUT': '86400', 00:47:18 INFO - 'USER': 'cltbld', 00:47:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:18 INFO - '_': '/tools/buildbot/bin/python'} 00:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:47:18 INFO - Cleaning up... 00:47:18 INFO - Return code: 0 00:47:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8ec61cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', '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 00:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:47:18 INFO - Using env: {'DISPLAY': ':0', 00:47:18 INFO - 'HOME': '/home/cltbld', 00:47:18 INFO - 'LANG': 'en_US.UTF-8', 00:47:18 INFO - 'LANGUAGE': 'en_US:en', 00:47:18 INFO - 'LOGNAME': 'cltbld', 00:47:18 INFO - 'MAIL': '/var/mail/cltbld', 00:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:18 INFO - 'MOZ_NO_REMOTE': '1', 00:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:18 INFO - 'NO_EM_RESTART': '1', 00:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:18 INFO - 'PWD': '/builds/slave/test', 00:47:18 INFO - 'SHELL': '/bin/bash', 00:47:18 INFO - 'SHLVL': '1', 00:47:18 INFO - 'TERM': 'linux', 00:47:18 INFO - 'TMOUT': '86400', 00:47:18 INFO - 'USER': 'cltbld', 00:47:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:18 INFO - '_': '/tools/buildbot/bin/python'} 00:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:18 INFO - Downloading/unpacking flake8 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47: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 00:47:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:47:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:47:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:47:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:47:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:47:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:47:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:47:21 INFO - no previously-included directories found matching 'docs/_build' 00:47:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:47:21 INFO - Running setup.py install for pep8 00:47:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:47:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:47:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:47:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:47:21 INFO - no previously-included directories found matching 'docs/_build' 00:47:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:47:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:47:21 INFO - Cleaning up... 00:47:21 INFO - Return code: 0 00:47:21 INFO - Running post-action listener: _resource_record_post_action 00:47:21 INFO - Running post-action listener: _start_resource_monitoring 00:47:21 INFO - Starting resource monitoring. 00:47:21 INFO - ##### 00:47:21 INFO - ##### Finished create-virtualenv step (success) 00:47:21 INFO - ##### 00:47:21 INFO - ##### 00:47:21 INFO - ##### Running install step. 00:47:21 INFO - ##### 00:47:21 INFO - Running pre-action listener: _resource_record_pre_action 00:47:21 INFO - Running main action method: install 00:47:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:47:22 INFO - Reading from file tmpfile_stdout 00:47:22 INFO - Detecting whether we're running mozinstall >=1.0... 00:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:47:22 INFO - Reading from file tmpfile_stdout 00:47:22 INFO - Output received: 00:47:22 INFO - Usage: mozinstall [options] installer 00:47:22 INFO - Options: 00:47:22 INFO - -h, --help show this help message and exit 00:47:22 INFO - -d DEST, --destination=DEST 00:47:22 INFO - Directory to install application into. [default: 00:47:22 INFO - "/builds/slave/test"] 00:47:22 INFO - --app=APP Application being installed. [default: firefox] 00:47:22 INFO - mkdir: /builds/slave/test/build/application 00:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:47:38 INFO - Reading from file tmpfile_stdout 00:47:38 INFO - Output received: 00:47:38 INFO - /builds/slave/test/build/application/firefox/firefox 00:47:38 INFO - Running post-action listener: _resource_record_post_action 00:47:38 INFO - ##### 00:47:38 INFO - ##### Finished install step (success) 00:47:38 INFO - ##### 00:47:38 INFO - ##### 00:47:38 INFO - ##### Running run-tests step. 00:47:38 INFO - ##### 00:47:38 INFO - Running pre-action listener: _resource_record_pre_action 00:47:38 INFO - Running main action method: run_tests 00:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:47:38 INFO - Python 2.7.3 00:47:38 INFO - Return code: 0 00:47:38 INFO - grabbing minidump binary from tooltool 00:47:38 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')]} 00:47:38 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 0x1e0a1c0>, '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 0x1e0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:47:38 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 00:47:38 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 00:47:38 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 00:47:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:47:38 INFO - Return code: 0 00:47:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:47:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:47:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:47:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:47:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:47:39 INFO - Return code: 0 00:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 00:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 00:47:39 INFO - Using env: {'DISPLAY': ':0', 00:47:39 INFO - 'HOME': '/home/cltbld', 00:47:39 INFO - 'LANG': 'en_US.UTF-8', 00:47:39 INFO - 'LANGUAGE': 'en_US:en', 00:47:39 INFO - 'LOGNAME': 'cltbld', 00:47:39 INFO - 'MAIL': '/var/mail/cltbld', 00:47:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:47:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:39 INFO - 'MOZ_NO_REMOTE': '1', 00:47:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:39 INFO - 'NO_EM_RESTART': '1', 00:47:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:39 INFO - 'PWD': '/builds/slave/test', 00:47:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:47:39 INFO - 'SHELL': '/bin/bash', 00:47:39 INFO - 'SHLVL': '1', 00:47:39 INFO - 'TERM': 'linux', 00:47:39 INFO - 'TMOUT': '86400', 00:47:39 INFO - 'USER': 'cltbld', 00:47:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862', 00:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:39 INFO - '_': '/tools/buildbot/bin/python'} 00:47:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 00:47:39 INFO - mozversion application_buildid: 20160624001256 00:47:39 INFO - mozversion application_changeset: 085b95afe6e38af8f920454caf9bdbb6db50afec 00:47:39 INFO - mozversion application_display_name: Nightly 00:47:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:47:39 INFO - mozversion application_name: Firefox 00:47:39 INFO - mozversion application_remotingname: firefox 00:47:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:47:39 INFO - mozversion application_vendor: Mozilla 00:47:39 INFO - mozversion application_version: 50.0a1 00:47:39 INFO - mozversion platform_buildid: 20160624001256 00:47:39 INFO - mozversion platform_changeset: 085b95afe6e38af8f920454caf9bdbb6db50afec 00:47:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:47:39 INFO - mozversion platform_version: 50.0a1 00:47:39 INFO - using testdate: 1466754459 00:47:39 INFO - actual date: 1466754459 00:47:39 INFO - starting webserver on 'localhost:38365' 00:47:39 INFO - SUITE-START | Running 2 tests 00:47:39 INFO - TEST-START | dromaeo_css 00:47:39 INFO - operating with platform_type : linux_ 00:47:39 INFO - Initialising browser for dromaeo_css test... 00:47:39 INFO - TEST-INFO | started process 24774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfowh0V/profile http://localhost:38365/getInfo.html) 00:47:44 INFO - PROCESS | 24774 | __metrics Screen width/height:1600/1200 00:47:44 INFO - PROCESS | 24774 | colorDepth:24 00:47:44 INFO - PROCESS | 24774 | Browser inner width/height: 1024/697 00:47:44 INFO - PROCESS | 24774 | __metrics 00:47:45 INFO - PROCESS | 24774 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:47:46 INFO - TEST-INFO | 24774: exit 0 00:47:46 INFO - Browser initialized. 00:47:46 INFO - Running cycle 1/1 for dromaeo_css test... 00:47:46 INFO - TEST-INFO | started process 24852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfowh0V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:47:58 INFO - PROCESS | 24852 | RSS: Main: 176361472 00:47:58 INFO - PROCESS | 24852 | 00:48:50 INFO - PROCESS | 24852 | 1466754530014 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] 00:51:02 INFO - PROCESS | 24852 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38365/tests/dromaeo/cssquery-ext.html) 00:51:03 INFO - PROCESS | 24852 | RSS: Main: 280023040 00:51:03 INFO - PROCESS | 24852 | 00:54:06 INFO - PROCESS | 24852 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-ext.html (next: http://localhost:38365/tests/dromaeo/cssquery-jquery.html) 00:54:06 INFO - PROCESS | 24852 | RSS: Main: 263860224 00:54:06 INFO - PROCESS | 24852 | 00:57:09 INFO - PROCESS | 24852 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38365/tests/dromaeo/cssquery-mootools.html) 00:57:09 INFO - PROCESS | 24852 | RSS: Main: 268292096 00:57:09 INFO - PROCESS | 24852 | 01:00:12 INFO - PROCESS | 24852 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38365/tests/dromaeo/cssquery-prototype.html) 01:00:12 INFO - PROCESS | 24852 | RSS: Main: 261251072 01:00:12 INFO - PROCESS | 24852 | 01:03:15 INFO - PROCESS | 24852 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38365/tests/dromaeo/cssquery-yui.html) 01:03:16 INFO - PROCESS | 24852 | RSS: Main: 245456896 01:03:16 INFO - PROCESS | 24852 | 01:06:19 INFO - PROCESS | 24852 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-yui.html (next: http://localhost:38365/tests/dromaeo/cssquery-dojo.html) 01:06:19 INFO - PROCESS | 24852 | RSS: Main: 290021376 01:06:19 INFO - PROCESS | 24852 | 01:06:19 INFO - PROCESS | 24852 | __start_tp_report 01:06:19 INFO - PROCESS | 24852 | _x_x_mozilla_page_load 01:06:19 INFO - PROCESS | 24852 | _x_x_mozilla_page_load_details 01:06:19 INFO - PROCESS | 24852 | |i|pagename|runs| 01:06:19 INFO - PROCESS | 24852 | |0;dojo.html;2567.255495906187;2629.934251643709;2637.8153529252936;2665.5735082386823;2684.798640101993;4666.253399456088;4714.9528504714945;4733.668643194977;4815.301781241717;4867.561919427251;4765.07081119181;4777.641676874231;4789.233722604384;4791.880202994927;4874.805007799692;4355.150745604608;4363.80362883671;4382.671299652523;4411.823527058922;4517.0514192019555;4397.362382454542;4445.088756804864;4489.304157855538;4524.841630542932;4539.024109816389;4255.87232383029;4443.688941774077;4474.798634061475;4493.977530112361;4502.549745025488;4265.1469706058915;4324.610785029363;4346.913061738779;4361.542038086019;4391.165678521103;4303.2469317869245;4321.2653848845775;4364.345348197764;4368.847090351855;4431.313146462304;4816.614670826326;4834.444038935532;4851.393575803025;4859.927101093486;4871.196252618313;4973.179425394806;5080.491950804927;5132.871678208037;5211.5049070338255;5219;5223.582113430954;5226.05930932432;5228.189630607262;5240.973795131;5242.18746094356;4816.277558366203;4886.951130488721;4887.853364399074;4890.682105663121;4894.143524883131;5121.1550094234035;5143.5113664201845;5164.845054648366;5166.819161329336;5287.762050707727;5010.64925455222;5025;5033.043721692867;5034;5039.294498770175;5064.037832811754;5065.341505604248;5074.441811400743;5079.390473143247;5110.565601923804;4910.926336104962;4992.475790041994;5039.748012599355;5045.091883461012;5081.7713202905215;5022.422421421583;5055.418626857959;5056.9494305057215;5097.490250974873;5105.566026887682;4243.575642435731;4346.67399944999;4358.956410435855;4363.280058790264;4422.115576884636;3706.6664000240107;3813.637704418076;3818.8161669882425;3861.4980052593546;3888.4167374893427;4378.912421751611;4385.144896745104;4386.649068074546;4430.579094985971;4436.733795972252;4992.301077849104;5142.71715055668;5148.613853960968;5149.382074151051;5186.066508028515;4303.913921721548;4325.286327755948;4374.103308821684;4384.671149663788;4390.121975604892;4626.398568186114;4640.280756482751;4645.117427688729;4647.95352046482;4673.626109911267;4684.718916864999;4810.879728006757;4811.639127065414;4814.951850481591;4848.684835485682;5070.138076527073;5143.6399452037995;5164.7417629119145;5231.633785634969;5245.396779370421;4839.080574690797;4848.927266091082;4850.078485087822;4850.733209673502;4892.168331383745;5062.31658726082;5099.5410413063;5112.284280200849;5116.820911268088;5170.146925757208;4999.875003124951;5126.307948426915;5161.509656582619;5169.147090729987;5224.9738751306;5071.340725705634;5074.063186635374;5083.847484575321;5086.694798312114;5127.179651255781;4859.829905953275;5050.898982020412;5062.848114556569;5065.366829146356;5066.898662026812;4893.877653058702;4903.632227582874;4940.92588611164;4998.525140111684;5010;5062.164742817394;5062.898742025065;5068.062408454448;5076.9338438928235;5100.6429549931145;4826.227803551415;4858.295547145714;4972.726500042532;4973.428055773632;5018.824341148188 01:06:19 INFO - PROCESS | 24852 | |1;ext.html;545.2031472196117;578.5689661202405;582.4932308891265;587.362711458068;602.5661523702934;27169.456610867797;40328;40656.39015414764;40666.59333406665;40669;40362.79818600903;40770;40771.99999999993;40796.38805417914;40811.795941020326;7792.532448053106;7951.801204969893;7966.721164759235;8001.959990200041;8008.199180081974;7759.030121234846;7849.5682737449415;7868.9606551967445;7873.015873015873;7874.724384646539;7876.488028278143;7892.921070789304;7922.326602238817;7926.603669816515;7932.444728868982;7834.56909869957;7892.842143157105;7900.091489478726;7901.762947111567;7909.446338756289;7754.728584499516;7827.373810095179;7827.5519028979825;7827.6477558510005;7831.530108193527;37945.430818537745;38358.424623630664;38367.616323836686;38406.23187536233;38463.8076809617;2899.6810350861388;2983.2690990707197;3322.900312990614;3614.150674591469;3629.800360980145;26835.463290734075;29587;29605;29742.702572974427;29809.40381192364;3568.8572457101686;3599.6940260077927;3693.630636936312;3735.0475628714776;3737.0657335666083;245993;246415;247437;247890;248535.75732121404;31132.066038018897;32142;53855;54462;54493;32410.189745256084;32629.836850815595;32724.345513089604;32845.67154328426;32892.83553582217;13501.392437340342;13526.053176277566;13586.184828910296;13587.252701101534;13598.592042238748;11407;11461.484233209525;11493.942530287462;11498.310101393776;11503.482343294405;7890;7921.564313962787;7982.68069277234;7984.880226796603;8046.356291496666;2949.2479417748764;2988.5367767995995;2997.685243049492;3020.8338541379994;3044.4824379855477;859.5100792548187;860.2386887604515;866.7139843851514;917.8164367126468;937.4000639590668;27908.720912791017;28047.71952280451;28174.43651127007;28316.71683283182;28822.567661485093;907.832051070554;930.8371035068972;949.9360715997989;954.2747511890874;962.432165022626;14616.415343386358;14944;14945.17801520905;15083.773743393858;15254.313555890012;405931;408350;409490;410377;410392;49199.26201106986;49683;49685.75157124191;49822;49862;1075.8708954925303;1153.4002318794348;1178.1988247991449;1192.2607983050564;1200.975980480403;28263.858680706464;28687.713122868503;28794.424111517234;29354.55968160522;29363.265918352212;41978.16043679048;42198.57801421946;42409.36385954152;42433.57566424296;42516.57483425126;309997;311497;311704;313000;315697;21513.784862151177;24010.27969160928;24629.50740985206;24776.628350575116;24919.501609967338;42323;42535;42749.786251068545;42878;43263.35104973365;35650.8217458911;35693.64306357007;36283;36467;36618.267634646625;35552.822235888656;35840.4623930636;35873.64126358703;35974.10064748298;36310;34862.82568587141;35405.82297088498;35672.821635891654;35909;35991.46012809758;32042.19894502656;32732.50901236531;32890.83554582212;33575.49636755402;33616.15959601029;24981.87509062516;24986.75013249844;25205;25350.239492815246;25865.612015819403 01:06:19 INFO - PROCESS | 24852 | |2;jquery.html;365.1728834190559;372.89186136020555;376.3921267153546;378.89580365399513;383.81385028261303;16155.273012714426;17478.65042699147;17953.10234488277;17962.37131700389;17970.371037013676;11764.117691173153;15740.134292613902;16583.336666533356;16613;17237.741433878502;4521.457425108983;4712.246040633499;4752;4754.072955773626;4756.286557016458;3417.1969587147;5147.613928955325;5464.4262352453015;5469.234307196995;5545.584081193906;5535.806246781363;5544.112941929292;5562.3881373048935;5568.1091025435935;5582.637128586649;5821.796237131702;5998.370171132012;5999.910001349983;6002.639841609495;6004.939950600482;3346;4951.356323677899;5208.062548741225;5239.633225674204;5253.527182553588;12400.503979840796;12414.006879449713;12517.248965062034;17810.821891781045;20429.591408171902;1808.4303444414968;1863.5434318591897;1980.2178139634764;2038.2967876082728;2340.9882950585306;8975.147361000694;8988.415752976101;8991.550422478915;9380.953095234549;9464.57409416571;1704.3353092294014;1771.2029586685915;1771.5482551949299;1783;1789.5705030792647;65071;66345;68336.3166368335;69124.30875691229;69598.65200673965;9998.200143988464;10009.69970900874;10141.391516509033;10151.781786185706;10342.37945723244;14085.295735213404;14205.85794142066;14207;14207.218602976936;14237.288135593386;7137.464690148259;7307.415406767446;7525.172231054579;7527.172011078777;7561.432892533082;7095.254998225215;7101.573905565682;7120.394766444807;7258.745943891939;7325.340719335285;4348.913021739548;4352.064306174125;4380.67144964129;4486.730796152241;4525.841595544141;1680.521141395564;1805.5847155154388;1812.5559237986777;1818.1545581304756;1842.7235914612916;806.1776987472745;848.0205362805968;862.4566523090539;878.547548012774;890.5369208011798;16226.188690565425;16453.012819230644;16678.49964501067;16783.496495104922;17307.653846923244;795.4670370851543;819.1317203764029;834.8956380452444;850.9492123981175;880.445319448756;9082.364234503653;9477;9532;9573.377730447637;9696.903030969741;400416;426274;428479;432897;434699;49885.50114498881;55339;79148.60425697835;79742;83539.58230208931;935.1023017902753;946.2666433514082;954.5609019850807;958.5399008475831;962.956666949989;14932.7760083601;15127.319270632628;15194.392224310905;15289.617759555655;15615.843841561438;36948.81525592462;37115.44326835046;37239.324230409155;37788.62211377851;38476.42285365666;50619.49380506295;51652.74173629108;53726.194107089206;55004;56158.71920640371;7123.715051397886;7345.6694448751;7703.807404814925;7951;7986.121526632182;10957.452127393757;11414.771704566028;11503.309801411942;11533.308001519936;11543.36511491876;9955.751106222402;10118.443485608068;10126.746831329276;10257.487125643836;10325.432101234504;9938.900610993798;10086.899131008597;10261.768587769217;10269.84595231087;10428.478576071015;9546.85679714791;10116.59533618647;10453.163746900078;10463.581456741646;10712.89287107119;7615.923840761743;7673.961630191813;7690.884636730341;7833.804154895945;7944.801379965547;9931.453770042717;10042.648507302209;10094.24293178;10115.190784737057;10420.843687344544 01:06:19 INFO - PROCESS | 24852 | |3;mootools.html;1197.8981786548143;1357.8302712160976;1399.4122468563203;1461.6272850423147;1683.949481515555;6556.311587283338;7603.771886843389;7837.843243135134;7854.5287282763;8012.759617211478;7787.493812902171;7943.841123177533;7948.92051079489;7958.084820245674;7958.522488650685;1844.5480857190007;2155.795199456057;2234.1398561553756;2236.519148383097;2287.1080278691325;2268.920587779428;2285.405794493435;2293.81649468043;2295.1393227539675;2295.517941232343;2222.4999375140624;2232.363776323748;2245.5059886824956;2254.4814692620707;2259.197984715427;1793.2020250988317;2078.3972647932233;2139.7111389962465;2147.066026278558;2176.064292354287;2151.505153814616;2176.5973294940486;2178.063432723928;2180.0189914538523;2181.2692747929464;7619.238076192391;7668.156502784689;7673.577953212571;7675.117361503443;7708.6916523339;4590.127875703605;4738.2892566115015;4741.383620129395;4743.691660042086;4755.476897541268;2802.9299267518477;2959.422912532057;3005.3087789808465;3054.2975115723507;3054.3433161870303;961.038961038961;961.1253759079274;974.3715303629119;998.4708104704446;999.6351331763926;10874.130069594414;10874.891251087467;10904.291221070605;10905.236633435663;10928.562857485611;4118.588141185857;4293.334533147367;4293.441852559147;4297.634701050446;4347.6304514116655;9208.723738287728;9208.861867071999;9224.077592240856;9286.535673216313;9319.673811416567;4750.857474275777;4764.404449443819;4766.833160839354;4772.093302272557;4774.665773395829;3420.521127042216;4152.730072545275;4265.381519679691;4278.187144442546;4279.893002674896;3732.197577520846;3785.280796648628;3840.423936409561;3873.3221686205366;3915.686745060388;1183.5798291606527;1200.9579664711694;1209.3529961470572;1230.3233221728015;1247.7941139712027;664.963427011519;708.4084789201074;751.0986815821036;761.493606751504;791.125805984379;4710.62315014798;4768.642351823627;4907.2393778964315;4945.2087665973995;5007.349044624249;388.4503427649844;419.6097629204869;422.9386738922839;425.7934901572735;427.5318526213791;3262.7112290645537;3289.2434740009453;3291.325278317939;3324.6010478742705;3330.7168890644566;9475.90524094764;9535.427874327424;9827.901720982842;9907.356021858555;9914.900850991398;9842.655507057361;9862.950685246671;9875.308728388944;9888.604455821687;9893.851592226123;7193.9280607194305;7387.593682347522;7434.962825185948;7445.181030086686;7477.738279160203;4791.544803243686;4797.304390863235;4824.855254342376;4828.179209534317;4849.75751212445;9126.543672816466;9131.315151363542;9161.31290153228;9166.954165229397;9207.723768286962;8324.125966773643;8669.046404895582;8674.826503470022;8874.778130546789;8881.289496840109;5506.531944784578;5683.033884239772;5688.402717714746;6804.727810887509;6988;6572.737090516326;6603.9009414859775;7254.056972593529;7531.359834413917;7538.773836784905;6873.48448866327;6874.209465911485;7001.649917504003;7098.041764361951;7125.893111603434;6811.659417029228;6813.625250611066;6846.110005699227;6905.309469053054;6935.653217339213;5663.858403539944;5723.198752174782;5843.590948633555;5875.148103525051;5891.204687367151;4323.48118225815;4328.632066274402;4392.846250381222;4408.537103604075;4487.394201782718;4406.625436837905;4419.226635338867;4424.070945101565;4595.540445955377;4601.355810186509 01:06:19 INFO - PROCESS | 24852 | |4;prototype.html;301.36412170320625;304.32591809142747;305.85319046857506;307.5187331825694;309.77076963047324;4697.318888761128;4834.927476087862;4899.358714830531;4900.58345040672;4905.33777939978;4818.5663290303955;4819.590334821544;4824.817919609701;4825.8793530161765;4829.420469543659;3587.587427445851;3651.3610118229335;3660.432632941898;3805.6004119567533;3819.9495138836905;3707.295613833363;3715.6098609646006;3723.813809309537;3724.3296206682785;3727.9627203728023;3689.206820533585;3706.0549559862197;3706.981465092671;3715.7213209009296;3746.775193488386;3578.4632305154173;3615.403458429382;3720.4605332226674;3740.4202348636004;3743.644353786386;3195.1532843796413;3224.9355012899846;3234.822084785336;3252.6259480159847;3255.4302996975434;4661.487236403993;4665.346851440801;4679.040796636681;4680.578747912704;4689.484156742756;4068.434065797393;4144.8756537303925;4215.473065866767;4222.0289333453475;4232.661387089025;4965.627577931669;4971.328870602459;5001.699898006132;5032.993401319751;5048.081728942978;3523.242502861897;3528.417811061172;3534.8939531814085;3536.717062635009;3546.840392182358;5168.2764412982215;5188.896222075575;5229.189475631283;5250.501202385767;5264.578833693334;3451.171718787473;3655.1044993976648;3656.8902932912056;3662.3407786598136;3673.94489082664;3693.4118329118737;3699.741018128705;3706.40551613866;3718.8326525306425;3731.3097077040834;4162.708610397243;4164.896302479845;4228.957710422918;4234.491860976641;4254.31930891056;4822.469528351879;4966.404031516241;4977;4993.450720420751;5054.584716279448;1277.9552715655093;1287.4657017337888;1301.8567957524665;1306.2815451501635;1311.3574348569132;825.86443639995;827.2678679368802;842.9536375499406;850.987325083149;855.3456605696647;4388.407564978687;4394.868153955386;4404.55954404557;4415.580519850609;4430.667699922518;5072.213806859942;5175.611829112831;5181.145111056709;5187.584993200535;5194.376674798973;4303.913921721548;4367.650587952956;4375;4376.205755640172;4408.404865343137;2755.7106503817213;2760.2961244882426;2765.612814206013;2767.750902418792;2775.4449110178043;4819.108464933998;4825.227963525819;4825.9758701206265;4828.589569886599;4841.927371089437;5070.847874563769;5251.8161864335325;5253.028189784902;5287.841364759063;5291.735413229323;4801.447833499193;4816.903661926812;4819.614430845524;4822.107910036654;4836.298736683161;5117.257997590403;5125.410577783603;5131.435542090442;5171.120909445479;5172.844814655567;4869.391326084239;4943.826966056171;4988.725620090785;5044.293798868088;5048.899022019613;4781.354517140281;4794.544518270759;4799.544043315879;4800.879978000578;4829.203181475017;3657.7139287945033;3667.706583473369;3676.540432445944;3690.1697118148204;3693.5937046924278;5041.6470847040355;5112.130937740668;5174.7153906535505;5193.506616871391;5211.322528071327;4917.114919314415;4945;4969.82605608802;4987.501249874984;5007.37407824022;4880.80476780939;4932.950670493249;5025.84922452327;5030.748462576929;5038.647294689336;4628.9537104628525;4908.239222920453;4930.605551555938;4952.925706114339;4962.429320628174;4869.829555965524;4994.751312171957;5016.774245158904;5020.824271150492;5022.748862556785;4918.622785620032;4925.21196608541;4938.901221975612;4991.301217829434;5013.2981382607195 01:06:19 INFO - PROCESS | 24852 | |5;yui.html;612.7947137708867;624.712632189193;688.4320435640597;716.4411758828114;718.1669263654162;12669.936650316748;13781.86218137817;13785.517506887261;13785.724285514283;13832.723345533082;11314.773704525925;12996.61010169694;13000.869991300084;13088.73822523549;13185.472581096745;768.627215800335;780.1808101493438;784.145281643009;785.0696924144878;785.7524879662916;769.3268390158611;769.6882762481204;770.4144849914078;770.452978385347;774.0324594257179;822.5681517203457;823.3824631526355;829.601791140253;830.8795224692416;830.9958450207771;806.753940048285;811.5414790643297;812.5287333346645;812.9756107316731;813.3046245460135;599.1043390131738;600.7747094839435;602.105872778923;602.6022824935521;603.3423568310519;11604.6518604442;11776.88223117775;11796.410179490991;11855.170138090338;11875.16873818833;10979;11090.722731931686;11225.775484490265;11358.148138889534;11563.884361156364;9815.36200146988;9872;9954.950225248827;9975.301728878982;10023.44871032093;3239.8542065607103;3287.96712032879;3307.2889328794427;3321.3025264694443;3417.5898892132855;41925.580744192775;57317;58845.117323240185;60346.396536034954;61273.693631532005;10863.40251286171;10903.890961090447;10982.231243812856;11051.447427628586;11132.888671113347;13872.653183670287;17278.30886764515;17985.1007449627;19798.40604781859;19817.702734458995;7005.474589405815;7074.893876591856;7088.610126443095;7151.177614574286;7511.737089201852;3563.3051554947056;3631.5279013728045;3720.8325625346924;3809.1810260794064;3887.1448281378052;2844.630198074237;3003.9549406758915;3005.248687828043;3005.5040918248246;3008.458477474032;497.524863755113;521.8643152780229;522.8954209158184;524.0645447875523;527.5805734441052;489.963726717996;504.364500729084;544.4501053935475;550.4440515079798;587.8853623543454;8092.473989190684;8197.590120493951;8228.341732661493;8339.24946754795;8396.79008024792;568.2385603291609;586.8092869817241;629.3580547841268;641.2721561028173;656.5305806348389;3728.447094810384;3780.771109803878;3860.517435320585;3916.1776027034643;3963.504561929759;84038.27693784483;93495.53252233696;93649;94141.5292923531;94663;78987.60506197432;79068;79173.60413198013;82055.17944820476;82199;41540.58459415367;55196.89606207854;55679.721601391735;72682.27317726755;72701.27298727051;7485.214052524624;7577.659005344883;7679.155292917663;7713.6143192841255;7845.333146682367;42897.35653965255;43636.56363436452;43955.34066989062;44170.77914610406;44178.01198946119;57888.710556446946;63338.683306583174;63420;63477.36522634899;63813.3618663826;9367.391119577205;9567.186789123003;9581.185599224144;9601.855972160563;9779.902200978184;10699.89300106989;10773.138148947908;10997.12023038171;11054.944725276322;11098.50056747432;10268.743281418025;10798.568057277935;10839;11049;11619.535218591162;11981.772916780461;12150.513979440724;12233.694157645774;12311;12546.623601291976;11039.116870650489;11304.434778261219;11647.41762911868;11736.471858766547;12672.936635316764;9668.806623867624;9989.800203996025;10248.436336001294;10299.53652085673;10448.268621196747;10207.387556746618;10243.795124097625;10456.68629941103;10565;10652.520636571218 01:06:19 INFO - PROCESS | 24852 | __end_tp_report 01:06:19 INFO - PROCESS | 24852 | __start_cc_report 01:06:19 INFO - PROCESS | 24852 | _x_x_mozilla_cycle_collect,974 01:06:19 INFO - PROCESS | 24852 | __end_cc_report 01:06:19 INFO - PROCESS | 24852 | __startTimestamp1466755579357__endTimestamp 01:06:19 INFO - PROCESS | 24852 | 01:06:19 INFO - PROCESS | 24852 | ------- Summary: start ------- 01:06:19 INFO - PROCESS | 24852 | Number of tests: 6 01:06:19 INFO - PROCESS | 24852 | 01:06:19 INFO - PROCESS | 24852 | [#0] dojo.html Cycles:165 Average:4741.89 Median:4874.81 stddev:505.96 (10.4%) stddev-sans-first:477.88 01:06:19 INFO - PROCESS | 24852 | Values: 2567.3 2629.9 2637.8 2665.6 2684.8 4666.3 4715.0 4733.7 4815.3 4867.6 4765.1 4777.6 4789.2 4791.9 4874.8 4355.2 4363.8 4382.7 4411.8 4517.1 4397.4 4445.1 4489.3 4524.8 4539.0 4255.9 4443.7 4474.8 4494.0 4502.5 4265.1 4324.6 4346.9 4361.5 4391.2 4303.2 4321.3 4364.3 4368.8 4431.3 4816.6 4834.4 4851.4 4859.9 4871.2 4973.2 5080.5 5132.9 5211.5 5219.0 5223.6 5226.1 5228.2 5241.0 5242.2 4816.3 4887.0 4887.9 4890.7 4894.1 5121.2 5143.5 5164.8 5166.8 5287.8 5010.6 5025.0 5033.0 5034.0 5039.3 5064.0 5065.3 5074.4 5079.4 5110.6 4910.9 4992.5 5039.7 5045.1 5081.8 5022.4 5055.4 5056.9 5097.5 5105.6 4243.6 4346.7 4359.0 4363.3 4422.1 3706.7 3813.6 3818.8 3861.5 3888.4 4378.9 4385.1 4386.6 4430.6 4436.7 4992.3 5142.7 5148.6 5149.4 5186.1 4303.9 4325.3 4374.1 4384.7 4390.1 4626.4 4640.3 4645.1 4648.0 4673.6 4684.7 4810.9 4811.6 4815.0 4848.7 5070.1 5143.6 5164.7 5231.6 5245.4 4839.1 4848.9 4850.1 4850.7 4892.2 5062.3 5099.5 5112.3 5116.8 5170.1 4999.9 5126.3 5161.5 5169.1 5225.0 5071.3 5074.1 5083.8 5086.7 5127.2 4859.8 5050.9 5062.8 5065.4 5066.9 4893.9 4903.6 4940.9 4998.5 5010.0 5062.2 5062.9 5068.1 5076.9 5100.6 4826.2 4858.3 4972.7 4973.4 5018.8 01:06:19 INFO - PROCESS | 24852 | 01:06:19 INFO - PROCESS | 24852 | [#1] ext.html Cycles:180 Average:46529.76 Median:19956.40 stddev:87083.97 (436.4%) stddev-sans-first:87259.82 01:06:19 INFO - PROCESS | 24852 | Values: 545.2 578.6 582.5 587.4 602.6 27169.5 40328.0 40656.4 40666.6 40669.0 40362.8 40770.0 40772.0 40796.4 40811.8 7792.5 7951.8 7966.7 8002.0 8008.2 7759.0 7849.6 7869.0 7873.0 7874.7 7876.5 7892.9 7922.3 7926.6 7932.4 7834.6 7892.8 7900.1 7901.8 7909.4 7754.7 7827.4 7827.6 7827.6 7831.5 37945.4 38358.4 38367.6 38406.2 38463.8 2899.7 2983.3 3322.9 3614.2 3629.8 26835.5 29587.0 29605.0 29742.7 29809.4 3568.9 3599.7 3693.6 3735.0 3737.1 245993.0 246415.0 247437.0 247890.0 248535.8 31132.1 32142.0 53855.0 54462.0 54493.0 32410.2 32629.8 32724.3 32845.7 32892.8 13501.4 13526.1 13586.2 13587.3 13598.6 11407.0 11461.5 11493.9 11498.3 11503.5 7890.0 7921.6 7982.7 7984.9 8046.4 2949.2 2988.5 2997.7 3020.8 3044.5 859.5 860.2 866.7 917.8 937.4 27908.7 28047.7 28174.4 28316.7 28822.6 907.8 930.8 949.9 954.3 962.4 14616.4 14944.0 14945.2 15083.8 15254.3 405931.0 408350.0 409490.0 410377.0 410392.0 49199.3 49683.0 49685.8 49822.0 49862.0 1075.9 1153.4 1178.2 1192.3 1201.0 28263.9 28687.7 28794.4 29354.6 29363.3 41978.2 42198.6 42409.4 42433.6 42516.6 309997.0 311497.0 311704.0 313000.0 315697.0 21513.8 24010.3 24629.5 24776.6 24919.5 42323.0 42535.0 42749.8 42878.0 43263.4 35650.8 35693.6 36283.0 36467.0 36618.3 35552.8 35840.5 35873.6 35974.1 36310.0 34862.8 35405.8 35672.8 35909.0 35991.5 32042.2 32732.5 32890.8 33575.5 33616.2 24981.9 24986.8 25205.0 25350.2 25865.6 01:06:19 INFO - PROCESS | 24852 | 01:06:19 INFO - PROCESS | 24852 | [#2] jquery.html Cycles:180 Average:24914.59 Median:4504.09 stddev:69847.87 (1550.8%) stddev-sans-first:70019.49 01:06:19 INFO - PROCESS | 24852 | Values: 365.2 372.9 376.4 378.9 383.8 16155.3 17478.7 17953.1 17962.4 17970.4 11764.1 15740.1 16583.3 16613.0 17237.7 4521.5 4712.2 4752.0 4754.1 4756.3 3417.2 5147.6 5464.4 5469.2 5545.6 5535.8 5544.1 5562.4 5568.1 5582.6 5821.8 5998.4 5999.9 6002.6 6004.9 3346.0 4951.4 5208.1 5239.6 5253.5 12400.5 12414.0 12517.2 17810.8 20429.6 1808.4 1863.5 1980.2 2038.3 2341.0 8975.1 8988.4 8991.6 9381.0 9464.6 1704.3 1771.2 1771.5 1783.0 1789.6 65071.0 66345.0 68336.3 69124.3 69598.7 9998.2 10009.7 10141.4 10151.8 10342.4 14085.3 14205.9 14207.0 14207.2 14237.3 7137.5 7307.4 7525.2 7527.2 7561.4 7095.3 7101.6 7120.4 7258.7 7325.3 4348.9 4352.1 4380.7 4486.7 4525.8 1680.5 1805.6 1812.6 1818.2 1842.7 806.2 848.0 862.5 878.5 890.5 16226.2 16453.0 16678.5 16783.5 17307.7 795.5 819.1 834.9 850.9 880.4 9082.4 9477.0 9532.0 9573.4 9696.9 400416.0 426274.0 428479.0 432897.0 434699.0 49885.5 55339.0 79148.6 79742.0 83539.6 935.1 946.3 954.6 958.5 963.0 14932.8 15127.3 15194.4 15289.6 15615.8 36948.8 37115.4 37239.3 37788.6 38476.4 50619.5 51652.7 53726.2 55004.0 56158.7 7123.7 7345.7 7703.8 7951.0 7986.1 10957.5 11414.8 11503.3 11533.3 11543.4 9955.8 10118.4 10126.7 10257.5 10325.4 9938.9 10086.9 10261.8 10269.8 10428.5 9546.9 10116.6 10453.2 10463.6 10712.9 7615.9 7674.0 7690.9 7833.8 7944.8 9931.5 10042.6 10094.2 10115.2 10420.8 01:06:19 INFO - PROCESS | 24852 | 01:06:19 INFO - PROCESS | 24852 | [#3] mootools.html Cycles:180 Average:5089.47 Median:4773.38 stddev:2920.04 (61.2%) stddev-sans-first:2913.58 01:06:19 INFO - PROCESS | 24852 | Values: 1197.9 1357.8 1399.4 1461.6 1683.9 6556.3 7603.8 7837.8 7854.5 8012.8 7787.5 7943.8 7948.9 7958.1 7958.5 1844.5 2155.8 2234.1 2236.5 2287.1 2268.9 2285.4 2293.8 2295.1 2295.5 2222.5 2232.4 2245.5 2254.5 2259.2 1793.2 2078.4 2139.7 2147.1 2176.1 2151.5 2176.6 2178.1 2180.0 2181.3 7619.2 7668.2 7673.6 7675.1 7708.7 4590.1 4738.3 4741.4 4743.7 4755.5 2802.9 2959.4 3005.3 3054.3 3054.3 961.0 961.1 974.4 998.5 999.6 10874.1 10874.9 10904.3 10905.2 10928.6 4118.6 4293.3 4293.4 4297.6 4347.6 9208.7 9208.9 9224.1 9286.5 9319.7 4750.9 4764.4 4766.8 4772.1 4774.7 3420.5 4152.7 4265.4 4278.2 4279.9 3732.2 3785.3 3840.4 3873.3 3915.7 1183.6 1201.0 1209.4 1230.3 1247.8 665.0 708.4 751.1 761.5 791.1 4710.6 4768.6 4907.2 4945.2 5007.3 388.5 419.6 422.9 425.8 427.5 3262.7 3289.2 3291.3 3324.6 3330.7 9475.9 9535.4 9827.9 9907.4 9914.9 9842.7 9863.0 9875.3 9888.6 9893.9 7193.9 7387.6 7435.0 7445.2 7477.7 4791.5 4797.3 4824.9 4828.2 4849.8 9126.5 9131.3 9161.3 9167.0 9207.7 8324.1 8669.0 8674.8 8874.8 8881.3 5506.5 5683.0 5688.4 6804.7 6988.0 6572.7 6603.9 7254.1 7531.4 7538.8 6873.5 6874.2 7001.6 7098.0 7125.9 6811.7 6813.6 6846.1 6905.3 6935.7 5663.9 5723.2 5843.6 5875.1 5891.2 4323.5 4328.6 4392.8 4408.5 4487.4 4406.6 4419.2 4424.1 4595.5 4601.4 01:06:19 INFO - PROCESS | 24852 | 01:06:19 INFO - PROCESS | 24852 | [#4] prototype.html Cycles:180 Average:4149.13 Median:4801.16 stddev:1203.88 (25.1%) stddev-sans-first:1172.11 01:06:19 INFO - PROCESS | 24852 | Values: 301.4 304.3 305.9 307.5 309.8 4697.3 4834.9 4899.4 4900.6 4905.3 4818.6 4819.6 4824.8 4825.9 4829.4 3587.6 3651.4 3660.4 3805.6 3819.9 3707.3 3715.6 3723.8 3724.3 3728.0 3689.2 3706.1 3707.0 3715.7 3746.8 3578.5 3615.4 3720.5 3740.4 3743.6 3195.2 3224.9 3234.8 3252.6 3255.4 4661.5 4665.3 4679.0 4680.6 4689.5 4068.4 4144.9 4215.5 4222.0 4232.7 4965.6 4971.3 5001.7 5033.0 5048.1 3523.2 3528.4 3534.9 3536.7 3546.8 5168.3 5188.9 5229.2 5250.5 5264.6 3451.2 3655.1 3656.9 3662.3 3673.9 3693.4 3699.7 3706.4 3718.8 3731.3 4162.7 4164.9 4229.0 4234.5 4254.3 4822.5 4966.4 4977.0 4993.5 5054.6 1278.0 1287.5 1301.9 1306.3 1311.4 825.9 827.3 843.0 851.0 855.3 4388.4 4394.9 4404.6 4415.6 4430.7 5072.2 5175.6 5181.1 5187.6 5194.4 4303.9 4367.7 4375.0 4376.2 4408.4 2755.7 2760.3 2765.6 2767.8 2775.4 4819.1 4825.2 4826.0 4828.6 4841.9 5070.8 5251.8 5253.0 5287.8 5291.7 4801.4 4816.9 4819.6 4822.1 4836.3 5117.3 5125.4 5131.4 5171.1 5172.8 4869.4 4943.8 4988.7 5044.3 5048.9 4781.4 4794.5 4799.5 4800.9 4829.2 3657.7 3667.7 3676.5 3690.2 3693.6 5041.6 5112.1 5174.7 5193.5 5211.3 4917.1 4945.0 4969.8 4987.5 5007.4 4880.8 4933.0 5025.8 5030.7 5038.6 4629.0 4908.2 4930.6 4952.9 4962.4 4869.8 4994.8 5016.8 5020.8 5022.7 4918.6 4925.2 4938.9 4991.3 5013.3 01:06:19 INFO - PROCESS | 24852 | 01:06:19 INFO - PROCESS | 24852 | [#5] yui.html Cycles:180 Average:16691.75 Median:523.48 stddev:23512.45 (4491.6%) stddev-sans-first:23547.41 01:06:19 INFO - PROCESS | 24852 | Values: 612.8 624.7 688.4 716.4 718.2 12669.9 13781.9 13785.5 13785.7 13832.7 11314.8 12996.6 13000.9 13088.7 13185.5 768.6 780.2 784.1 785.1 785.8 769.3 769.7 770.4 770.5 774.0 822.6 823.4 829.6 830.9 831.0 806.8 811.5 812.5 813.0 813.3 599.1 600.8 602.1 602.6 603.3 11604.7 11776.9 11796.4 11855.2 11875.2 10979.0 11090.7 11225.8 11358.1 11563.9 9815.4 9872.0 9955.0 9975.3 10023.4 3239.9 3288.0 3307.3 3321.3 3417.6 41925.6 57317.0 58845.1 60346.4 61273.7 10863.4 10903.9 10982.2 11051.4 11132.9 13872.7 17278.3 17985.1 19798.4 19817.7 7005.5 7074.9 7088.6 7151.2 7511.7 3563.3 3631.5 3720.8 3809.2 3887.1 2844.6 3004.0 3005.2 3005.5 3008.5 497.5 521.9 522.9 524.1 527.6 490.0 504.4 544.5 550.4 587.9 8092.5 8197.6 8228.3 8339.2 8396.8 568.2 586.8 629.4 641.3 656.5 3728.4 3780.8 3860.5 3916.2 3963.5 84038.3 93495.5 93649.0 94141.5 94663.0 78987.6 79068.0 79173.6 82055.2 82199.0 41540.6 55196.9 55679.7 72682.3 72701.3 7485.2 7577.7 7679.2 7713.6 7845.3 42897.4 43636.6 43955.3 44170.8 44178.0 57888.7 63338.7 63420.0 63477.4 63813.4 9367.4 9567.2 9581.2 9601.9 9779.9 10699.9 10773.1 10997.1 11054.9 11098.5 10268.7 10798.6 10839.0 11049.0 11619.5 11981.8 12150.5 12233.7 12311.0 12546.6 11039.1 11304.4 11647.4 11736.5 12672.9 9668.8 9989.8 10248.4 10299.5 10448.3 10207.4 10243.8 10456.7 10565.0 10652.5 01:06:19 INFO - PROCESS | 24852 | -------- Summary: end -------- 01:06:19 INFO - PROCESS | 24852 | 01:06:20 INFO - TEST-INFO | 24852: exit 0 01:06:20 INFO - TEST-OK | dromaeo_css | took 1120626ms 01:06:20 INFO - TEST-START | kraken 01:06:20 INFO - operating with platform_type : linux_ 01:06:20 INFO - Initialising browser for kraken test... 01:06:20 INFO - TEST-INFO | started process 25033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpry0oFx/profile http://localhost:38365/getInfo.html) 01:06:24 INFO - PROCESS | 25033 | __metrics Screen width/height:1600/1200 01:06:24 INFO - PROCESS | 25033 | colorDepth:24 01:06:24 INFO - PROCESS | 25033 | Browser inner width/height: 1024/697 01:06:24 INFO - PROCESS | 25033 | __metrics 01:06:25 INFO - PROCESS | 25033 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:06:26 INFO - TEST-INFO | 25033: exit 0 01:06:26 INFO - Browser initialized. 01:06:26 INFO - Running cycle 1/1 for kraken test... 01:06:26 INFO - TEST-INFO | started process 25116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpry0oFx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:06:39 INFO - PROCESS | 25116 | RSS: Main: 176295936 01:06:39 INFO - PROCESS | 25116 | 01:06:41 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38365/tests/kraken/driver.html?testName=audio-beat-detection) 01:06:42 INFO - PROCESS | 25116 | RSS: Main: 234143744 01:06:42 INFO - PROCESS | 25116 | 01:06:45 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38365/tests/kraken/driver.html?testName=audio-dft) 01:06:46 INFO - PROCESS | 25116 | RSS: Main: 222920704 01:06:46 INFO - PROCESS | 25116 | 01:06:49 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38365/tests/kraken/driver.html?testName=audio-fft) 01:06:50 INFO - PROCESS | 25116 | RSS: Main: 288952320 01:06:50 INFO - PROCESS | 25116 | 01:06:52 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38365/tests/kraken/driver.html?testName=audio-oscillator) 01:06:52 INFO - PROCESS | 25116 | RSS: Main: 199507968 01:06:52 INFO - PROCESS | 25116 | 01:06:55 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38365/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:06:55 INFO - PROCESS | 25116 | RSS: Main: 203341824 01:06:55 INFO - PROCESS | 25116 | 01:06:58 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38365/tests/kraken/driver.html?testName=imaging-darkroom) 01:06:59 INFO - PROCESS | 25116 | RSS: Main: 239042560 01:06:59 INFO - PROCESS | 25116 | 01:07:02 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38365/tests/kraken/driver.html?testName=imaging-desaturate) 01:07:03 INFO - PROCESS | 25116 | RSS: Main: 235053056 01:07:03 INFO - PROCESS | 25116 | 01:07:06 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38365/tests/kraken/driver.html?testName=json-parse-financial) 01:07:07 INFO - PROCESS | 25116 | RSS: Main: 237752320 01:07:07 INFO - PROCESS | 25116 | 01:07:08 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38365/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:07:09 INFO - PROCESS | 25116 | RSS: Main: 224731136 01:07:09 INFO - PROCESS | 25116 | 01:07:11 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:07:11 INFO - PROCESS | 25116 | RSS: Main: 231407616 01:07:11 INFO - PROCESS | 25116 | 01:07:14 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:07:14 INFO - PROCESS | 25116 | RSS: Main: 238891008 01:07:14 INFO - PROCESS | 25116 | 01:07:17 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:07:18 INFO - PROCESS | 25116 | RSS: Main: 241262592 01:07:18 INFO - PROCESS | 25116 | 01:07:21 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:07:21 INFO - PROCESS | 25116 | RSS: Main: 239616000 01:07:21 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38365/tests/kraken/driver.html?testName=ai-astar) 01:07:23 INFO - PROCESS | 25116 | RSS: Main: 282800128 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | __start_tp_report 01:07:23 INFO - PROCESS | 25116 | _x_x_mozilla_page_load 01:07:23 INFO - PROCESS | 25116 | _x_x_mozilla_page_load_details 01:07:23 INFO - PROCESS | 25116 | |i|pagename|runs| 01:07:23 INFO - PROCESS | 25116 | |0;ai-astar;103;114;112;112;113;112;113;114;112;113 01:07:23 INFO - PROCESS | 25116 | |1;audio-beat-detection;164;138;142;186;140;163;159;134;191;130 01:07:23 INFO - PROCESS | 25116 | |2;audio-dft;162;164;162;162;162;164;163;164;165;163 01:07:23 INFO - PROCESS | 25116 | |3;audio-fft;76;78;76;108;75;77;75;75;98;75 01:07:23 INFO - PROCESS | 25116 | |4;audio-oscillator;87;87;130;87;87;85;122;86;86;138 01:07:23 INFO - PROCESS | 25116 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;117 01:07:23 INFO - PROCESS | 25116 | |6;imaging-darkroom;149;145;146;147;148;145;146;145;147;148 01:07:23 INFO - PROCESS | 25116 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;94 01:07:23 INFO - PROCESS | 25116 | |8;json-parse-financial;64;65;64;64;67;65;66;65;67;65 01:07:23 INFO - PROCESS | 25116 | |9;json-stringify-tinderbox;66;65;64;65;65;65;66;65;67;64 01:07:23 INFO - PROCESS | 25116 | |10;stanford-crypto-aes;82;84;83;82;87;83;83;84;91;84 01:07:23 INFO - PROCESS | 25116 | |11;stanford-crypto-ccm;150;134;141;140;133;127;130;129;139;134 01:07:23 INFO - PROCESS | 25116 | |12;stanford-crypto-pbkdf2;169;168;167;168;168;167;172;173;169;166 01:07:23 INFO - PROCESS | 25116 | |13;stanford-crypto-sha256-iterative;71;67;67;68;68;66;67;69;68;67 01:07:23 INFO - PROCESS | 25116 | __end_tp_report 01:07:23 INFO - PROCESS | 25116 | __start_cc_report 01:07:23 INFO - PROCESS | 25116 | _x_x_mozilla_cycle_collect,1904 01:07:23 INFO - PROCESS | 25116 | __end_cc_report 01:07:23 INFO - PROCESS | 25116 | __startTimestamp1466755643806__endTimestamp 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | ------- Summary: start ------- 01:07:23 INFO - PROCESS | 25116 | Number of tests: 14 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.19 (2.8%) stddev-sans-first:0.83 01:07:23 INFO - PROCESS | 25116 | Values: 103.0 114.0 112.0 112.0 113.0 112.0 113.0 114.0 112.0 113.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:161.00 stddev:21.52 (13.4%) stddev-sans-first:22.56 01:07:23 INFO - PROCESS | 25116 | Values: 164.0 138.0 142.0 186.0 140.0 163.0 159.0 134.0 191.0 130.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 01:07:23 INFO - PROCESS | 25116 | Values: 162.0 164.0 162.0 162.0 162.0 164.0 163.0 164.0 165.0 163.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.72 (15.4%) stddev-sans-first:12.27 01:07:23 INFO - PROCESS | 25116 | Values: 76.0 78.0 76.0 108.0 75.0 77.0 75.0 75.0 98.0 75.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#4] audio-oscillator Cycles:10 Average:99.50 Median:86.50 stddev:21.39 (24.7%) stddev-sans-first:22.21 01:07:23 INFO - PROCESS | 25116 | Values: 87.0 87.0 130.0 87.0 87.0 85.0 122.0 86.0 86.0 138.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:07:23 INFO - PROCESS | 25116 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:1.43 (1.0%) stddev-sans-first:1.22 01:07:23 INFO - PROCESS | 25116 | Values: 149.0 145.0 146.0 147.0 148.0 145.0 146.0 145.0 147.0 148.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 01:07:23 INFO - PROCESS | 25116 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 01:07:23 INFO - PROCESS | 25116 | Values: 64.0 65.0 64.0 64.0 67.0 65.0 66.0 65.0 67.0 65.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 01:07:23 INFO - PROCESS | 25116 | Values: 66.0 65.0 64.0 65.0 65.0 65.0 66.0 65.0 67.0 64.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:2.75 (3.3%) stddev-sans-first:2.79 01:07:23 INFO - PROCESS | 25116 | Values: 82.0 84.0 83.0 82.0 87.0 83.0 83.0 84.0 91.0 84.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:136.50 stddev:6.90 (5.1%) stddev-sans-first:5.01 01:07:23 INFO - PROCESS | 25116 | Values: 150.0 134.0 141.0 140.0 133.0 127.0 130.0 129.0 139.0 134.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:168.50 stddev:2.21 (1.3%) stddev-sans-first:2.35 01:07:23 INFO - PROCESS | 25116 | Values: 169.0 168.0 167.0 168.0 168.0 167.0 172.0 173.0 169.0 166.0 01:07:23 INFO - PROCESS | 25116 | 01:07:23 INFO - PROCESS | 25116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:0.88 01:07:23 INFO - PROCESS | 25116 | Values: 71.0 67.0 67.0 68.0 68.0 66.0 67.0 69.0 68.0 67.0 01:07:23 INFO - PROCESS | 25116 | -------- Summary: end -------- 01:07:23 INFO - PROCESS | 25116 | 01:07:25 INFO - TEST-INFO | 25116: exit 0 01:07:25 INFO - TEST-OK | kraken | took 64845ms 01:07:25 INFO - SUITE-END | took 1185s 01:07:25 INFO - Completed test suite (00:19:45) 01:07:25 INFO - javascript benchmark 01:07:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.255495906187, 2629.934251643709, 2637.8153529252936, 2665.5735082386823, 2684.798640101993, 4666.253399456088, 4714.9528504714945, 4733.668643194977, 4815.301781241717, 4867.561919427251, 4765.07081119181, 4777.641676874231, 4789.233722604384, 4791.880202994927, 4874.805007799692, 4355.150745604608, 4363.80362883671, 4382.671299652523, 4411.823527058922, 4517.0514192019555, 4397.362382454542, 4445.088756804864, 4489.304157855538, 4524.841630542932, 4539.024109816389, 4255.87232383029, 4443.688941774077, 4474.798634061475, 4493.977530112361, 4502.549745025488, 4265.1469706058915, 4324.610785029363, 4346.913061738779, 4361.542038086019, 4391.165678521103, 4303.2469317869245, 4321.2653848845775, 4364.345348197764, 4368.847090351855, 4431.313146462304, 4816.614670826326, 4834.444038935532, 4851.393575803025, 4859.927101093486, 4871.196252618313, 4973.179425394806, 5080.491950804927, 5132.871678208037, 5211.5049070338255, 5219.0, 5223.582113430954, 5226.05930932432, 5228.189630607262, 5240.973795131, 5242.18746094356, 4816.277558366203, 4886.951130488721, 4887.853364399074, 4890.682105663121, 4894.143524883131, 5121.1550094234035, 5143.5113664201845, 5164.845054648366, 5166.819161329336, 5287.762050707727, 5010.64925455222, 5025.0, 5033.043721692867, 5034.0, 5039.294498770175, 5064.037832811754, 5065.341505604248, 5074.441811400743, 5079.390473143247, 5110.565601923804, 4910.926336104962, 4992.475790041994, 5039.748012599355, 5045.091883461012, 5081.7713202905215, 5022.422421421583, 5055.418626857959, 5056.9494305057215, 5097.490250974873, 5105.566026887682, 4243.575642435731, 4346.67399944999, 4358.956410435855, 4363.280058790264, 4422.115576884636, 3706.6664000240107, 3813.637704418076, 3818.8161669882425, 3861.4980052593546, 3888.4167374893427, 4378.912421751611, 4385.144896745104, 4386.649068074546, 4430.579094985971, 4436.733795972252, 4992.301077849104, 5142.71715055668, 5148.613853960968, 5149.382074151051, 5186.066508028515, 4303.913921721548, 4325.286327755948, 4374.103308821684, 4384.671149663788, 4390.121975604892, 4626.398568186114, 4640.280756482751, 4645.117427688729, 4647.95352046482, 4673.626109911267, 4684.718916864999, 4810.879728006757, 4811.639127065414, 4814.951850481591, 4848.684835485682, 5070.138076527073, 5143.6399452037995, 5164.7417629119145, 5231.633785634969, 5245.396779370421, 4839.080574690797, 4848.927266091082, 4850.078485087822, 4850.733209673502, 4892.168331383745, 5062.31658726082, 5099.5410413063, 5112.284280200849, 5116.820911268088, 5170.146925757208, 4999.875003124951, 5126.307948426915, 5161.509656582619, 5169.147090729987, 5224.9738751306, 5071.340725705634, 5074.063186635374, 5083.847484575321, 5086.694798312114, 5127.179651255781, 4859.829905953275, 5050.898982020412, 5062.848114556569, 5065.366829146356, 5066.898662026812, 4893.877653058702, 4903.632227582874, 4940.92588611164, 4998.525140111684, 5010.0, 5062.164742817394, 5062.898742025065, 5068.062408454448, 5076.9338438928235, 5100.6429549931145, 4826.227803551415, 4858.295547145714, 4972.726500042532, 4973.428055773632, 5018.824341148188], "value": 4708.807237211337, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2031472196117, 578.5689661202405, 582.4932308891265, 587.362711458068, 602.5661523702934, 27169.456610867797, 40328.0, 40656.39015414764, 40666.59333406665, 40669.0, 40362.79818600903, 40770.0, 40771.99999999993, 40796.38805417914, 40811.795941020326, 7792.532448053106, 7951.801204969893, 7966.721164759235, 8001.959990200041, 8008.199180081974, 7759.030121234846, 7849.5682737449415, 7868.9606551967445, 7873.015873015873, 7874.724384646539, 7876.488028278143, 7892.921070789304, 7922.326602238817, 7926.603669816515, 7932.444728868982, 7834.56909869957, 7892.842143157105, 7900.091489478726, 7901.762947111567, 7909.446338756289, 7754.728584499516, 7827.373810095179, 7827.5519028979825, 7827.6477558510005, 7831.530108193527, 37945.430818537745, 38358.424623630664, 38367.616323836686, 38406.23187536233, 38463.8076809617, 2899.6810350861388, 2983.2690990707197, 3322.900312990614, 3614.150674591469, 3629.800360980145, 26835.463290734075, 29587.0, 29605.0, 29742.702572974427, 29809.40381192364, 3568.8572457101686, 3599.6940260077927, 3693.630636936312, 3735.0475628714776, 3737.0657335666083, 245993.0, 246415.0, 247437.0, 247890.0, 248535.75732121404, 31132.066038018897, 32142.0, 53855.0, 54462.0, 54493.0, 32410.189745256084, 32629.836850815595, 32724.345513089604, 32845.67154328426, 32892.83553582217, 13501.392437340342, 13526.053176277566, 13586.184828910296, 13587.252701101534, 13598.592042238748, 11407.0, 11461.484233209525, 11493.942530287462, 11498.310101393776, 11503.482343294405, 7890.0, 7921.564313962787, 7982.68069277234, 7984.880226796603, 8046.356291496666, 2949.2479417748764, 2988.5367767995995, 2997.685243049492, 3020.8338541379994, 3044.4824379855477, 859.5100792548187, 860.2386887604515, 866.7139843851514, 917.8164367126468, 937.4000639590668, 27908.720912791017, 28047.71952280451, 28174.43651127007, 28316.71683283182, 28822.567661485093, 907.832051070554, 930.8371035068972, 949.9360715997989, 954.2747511890874, 962.432165022626, 14616.415343386358, 14944.0, 14945.17801520905, 15083.773743393858, 15254.313555890012, 405931.0, 408350.0, 409490.0, 410377.0, 410392.0, 49199.26201106986, 49683.0, 49685.75157124191, 49822.0, 49862.0, 1075.8708954925303, 1153.4002318794348, 1178.1988247991449, 1192.2607983050564, 1200.975980480403, 28263.858680706464, 28687.713122868503, 28794.424111517234, 29354.55968160522, 29363.265918352212, 41978.16043679048, 42198.57801421946, 42409.36385954152, 42433.57566424296, 42516.57483425126, 309997.0, 311497.0, 311704.0, 313000.0, 315697.0, 21513.784862151177, 24010.27969160928, 24629.50740985206, 24776.628350575116, 24919.501609967338, 42323.0, 42535.0, 42749.786251068545, 42878.0, 43263.35104973365, 35650.8217458911, 35693.64306357007, 36283.0, 36467.0, 36618.267634646625, 35552.822235888656, 35840.4623930636, 35873.64126358703, 35974.10064748298, 36310.0, 34862.82568587141, 35405.82297088498, 35672.821635891654, 35909.0, 35991.46012809758, 32042.19894502656, 32732.50901236531, 32890.83554582212, 33575.49636755402, 33616.15959601029, 24981.87509062516, 24986.75013249844, 25205.0, 25350.239492815246, 25865.612015819403], "value": 16465.04599937884, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.1728834190559, 372.89186136020555, 376.3921267153546, 378.89580365399513, 383.81385028261303, 16155.273012714426, 17478.65042699147, 17953.10234488277, 17962.37131700389, 17970.371037013676, 11764.117691173153, 15740.134292613902, 16583.336666533356, 16613.0, 17237.741433878502, 4521.457425108983, 4712.246040633499, 4752.0, 4754.072955773626, 4756.286557016458, 3417.1969587147, 5147.613928955325, 5464.4262352453015, 5469.234307196995, 5545.584081193906, 5535.806246781363, 5544.112941929292, 5562.3881373048935, 5568.1091025435935, 5582.637128586649, 5821.796237131702, 5998.370171132012, 5999.910001349983, 6002.639841609495, 6004.939950600482, 3346.0, 4951.356323677899, 5208.062548741225, 5239.633225674204, 5253.527182553588, 12400.503979840796, 12414.006879449713, 12517.248965062034, 17810.821891781045, 20429.591408171902, 1808.4303444414968, 1863.5434318591897, 1980.2178139634764, 2038.2967876082728, 2340.9882950585306, 8975.147361000694, 8988.415752976101, 8991.550422478915, 9380.953095234549, 9464.57409416571, 1704.3353092294014, 1771.2029586685915, 1771.5482551949299, 1783.0, 1789.5705030792647, 65071.0, 66345.0, 68336.3166368335, 69124.30875691229, 69598.65200673965, 9998.200143988464, 10009.69970900874, 10141.391516509033, 10151.781786185706, 10342.37945723244, 14085.295735213404, 14205.85794142066, 14207.0, 14207.218602976936, 14237.288135593386, 7137.464690148259, 7307.415406767446, 7525.172231054579, 7527.172011078777, 7561.432892533082, 7095.254998225215, 7101.573905565682, 7120.394766444807, 7258.745943891939, 7325.340719335285, 4348.913021739548, 4352.064306174125, 4380.67144964129, 4486.730796152241, 4525.841595544141, 1680.521141395564, 1805.5847155154388, 1812.5559237986777, 1818.1545581304756, 1842.7235914612916, 806.1776987472745, 848.0205362805968, 862.4566523090539, 878.547548012774, 890.5369208011798, 16226.188690565425, 16453.012819230644, 16678.49964501067, 16783.496495104922, 17307.653846923244, 795.4670370851543, 819.1317203764029, 834.8956380452444, 850.9492123981175, 880.445319448756, 9082.364234503653, 9477.0, 9532.0, 9573.377730447637, 9696.903030969741, 400416.0, 426274.0, 428479.0, 432897.0, 434699.0, 49885.50114498881, 55339.0, 79148.60425697835, 79742.0, 83539.58230208931, 935.1023017902753, 946.2666433514082, 954.5609019850807, 958.5399008475831, 962.956666949989, 14932.7760083601, 15127.319270632628, 15194.392224310905, 15289.617759555655, 15615.843841561438, 36948.81525592462, 37115.44326835046, 37239.324230409155, 37788.62211377851, 38476.42285365666, 50619.49380506295, 51652.74173629108, 53726.194107089206, 55004.0, 56158.71920640371, 7123.715051397886, 7345.6694448751, 7703.807404814925, 7951.0, 7986.121526632182, 10957.452127393757, 11414.771704566028, 11503.309801411942, 11533.308001519936, 11543.36511491876, 9955.751106222402, 10118.443485608068, 10126.746831329276, 10257.487125643836, 10325.432101234504, 9938.900610993798, 10086.899131008597, 10261.768587769217, 10269.84595231087, 10428.478576071015, 9546.85679714791, 10116.59533618647, 10453.163746900078, 10463.581456741646, 10712.89287107119, 7615.923840761743, 7673.961630191813, 7690.884636730341, 7833.804154895945, 7944.801379965547, 9931.453770042717, 10042.648507302209, 10094.24293178, 10115.190784737057, 10420.843687344544], "value": 8116.221556067091, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.8981786548143, 1357.8302712160976, 1399.4122468563203, 1461.6272850423147, 1683.949481515555, 6556.311587283338, 7603.771886843389, 7837.843243135134, 7854.5287282763, 8012.759617211478, 7787.493812902171, 7943.841123177533, 7948.92051079489, 7958.084820245674, 7958.522488650685, 1844.5480857190007, 2155.795199456057, 2234.1398561553756, 2236.519148383097, 2287.1080278691325, 2268.920587779428, 2285.405794493435, 2293.81649468043, 2295.1393227539675, 2295.517941232343, 2222.4999375140624, 2232.363776323748, 2245.5059886824956, 2254.4814692620707, 2259.197984715427, 1793.2020250988317, 2078.3972647932233, 2139.7111389962465, 2147.066026278558, 2176.064292354287, 2151.505153814616, 2176.5973294940486, 2178.063432723928, 2180.0189914538523, 2181.2692747929464, 7619.238076192391, 7668.156502784689, 7673.577953212571, 7675.117361503443, 7708.6916523339, 4590.127875703605, 4738.2892566115015, 4741.383620129395, 4743.691660042086, 4755.476897541268, 2802.9299267518477, 2959.422912532057, 3005.3087789808465, 3054.2975115723507, 3054.3433161870303, 961.038961038961, 961.1253759079274, 974.3715303629119, 998.4708104704446, 999.6351331763926, 10874.130069594414, 10874.891251087467, 10904.291221070605, 10905.236633435663, 10928.562857485611, 4118.588141185857, 4293.334533147367, 4293.441852559147, 4297.634701050446, 4347.6304514116655, 9208.723738287728, 9208.861867071999, 9224.077592240856, 9286.535673216313, 9319.673811416567, 4750.857474275777, 4764.404449443819, 4766.833160839354, 4772.093302272557, 4774.665773395829, 3420.521127042216, 4152.730072545275, 4265.381519679691, 4278.187144442546, 4279.893002674896, 3732.197577520846, 3785.280796648628, 3840.423936409561, 3873.3221686205366, 3915.686745060388, 1183.5798291606527, 1200.9579664711694, 1209.3529961470572, 1230.3233221728015, 1247.7941139712027, 664.963427011519, 708.4084789201074, 751.0986815821036, 761.493606751504, 791.125805984379, 4710.62315014798, 4768.642351823627, 4907.2393778964315, 4945.2087665973995, 5007.349044624249, 388.4503427649844, 419.6097629204869, 422.9386738922839, 425.7934901572735, 427.5318526213791, 3262.7112290645537, 3289.2434740009453, 3291.325278317939, 3324.6010478742705, 3330.7168890644566, 9475.90524094764, 9535.427874327424, 9827.901720982842, 9907.356021858555, 9914.900850991398, 9842.655507057361, 9862.950685246671, 9875.308728388944, 9888.604455821687, 9893.851592226123, 7193.9280607194305, 7387.593682347522, 7434.962825185948, 7445.181030086686, 7477.738279160203, 4791.544803243686, 4797.304390863235, 4824.855254342376, 4828.179209534317, 4849.75751212445, 9126.543672816466, 9131.315151363542, 9161.31290153228, 9166.954165229397, 9207.723768286962, 8324.125966773643, 8669.046404895582, 8674.826503470022, 8874.778130546789, 8881.289496840109, 5506.531944784578, 5683.033884239772, 5688.402717714746, 6804.727810887509, 6988.0, 6572.737090516326, 6603.9009414859775, 7254.056972593529, 7531.359834413917, 7538.773836784905, 6873.48448866327, 6874.209465911485, 7001.649917504003, 7098.041764361951, 7125.893111603434, 6811.659417029228, 6813.625250611066, 6846.110005699227, 6905.309469053054, 6935.653217339213, 5663.858403539944, 5723.198752174782, 5843.590948633555, 5875.148103525051, 5891.204687367151, 4323.48118225815, 4328.632066274402, 4392.846250381222, 4408.537103604075, 4487.394201782718, 4406.625436837905, 4419.226635338867, 4424.070945101565, 4595.540445955377, 4601.355810186509], "value": 4018.2108462681667, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.36412170320625, 304.32591809142747, 305.85319046857506, 307.5187331825694, 309.77076963047324, 4697.318888761128, 4834.927476087862, 4899.358714830531, 4900.58345040672, 4905.33777939978, 4818.5663290303955, 4819.590334821544, 4824.817919609701, 4825.8793530161765, 4829.420469543659, 3587.587427445851, 3651.3610118229335, 3660.432632941898, 3805.6004119567533, 3819.9495138836905, 3707.295613833363, 3715.6098609646006, 3723.813809309537, 3724.3296206682785, 3727.9627203728023, 3689.206820533585, 3706.0549559862197, 3706.981465092671, 3715.7213209009296, 3746.775193488386, 3578.4632305154173, 3615.403458429382, 3720.4605332226674, 3740.4202348636004, 3743.644353786386, 3195.1532843796413, 3224.9355012899846, 3234.822084785336, 3252.6259480159847, 3255.4302996975434, 4661.487236403993, 4665.346851440801, 4679.040796636681, 4680.578747912704, 4689.484156742756, 4068.434065797393, 4144.8756537303925, 4215.473065866767, 4222.0289333453475, 4232.661387089025, 4965.627577931669, 4971.328870602459, 5001.699898006132, 5032.993401319751, 5048.081728942978, 3523.242502861897, 3528.417811061172, 3534.8939531814085, 3536.717062635009, 3546.840392182358, 5168.2764412982215, 5188.896222075575, 5229.189475631283, 5250.501202385767, 5264.578833693334, 3451.171718787473, 3655.1044993976648, 3656.8902932912056, 3662.3407786598136, 3673.94489082664, 3693.4118329118737, 3699.741018128705, 3706.40551613866, 3718.8326525306425, 3731.3097077040834, 4162.708610397243, 4164.896302479845, 4228.957710422918, 4234.491860976641, 4254.31930891056, 4822.469528351879, 4966.404031516241, 4977.0, 4993.450720420751, 5054.584716279448, 1277.9552715655093, 1287.4657017337888, 1301.8567957524665, 1306.2815451501635, 1311.3574348569132, 825.86443639995, 827.2678679368802, 842.9536375499406, 850.987325083149, 855.3456605696647, 4388.407564978687, 4394.868153955386, 4404.55954404557, 4415.580519850609, 4430.667699922518, 5072.213806859942, 5175.611829112831, 5181.145111056709, 5187.584993200535, 5194.376674798973, 4303.913921721548, 4367.650587952956, 4375.0, 4376.205755640172, 4408.404865343137, 2755.7106503817213, 2760.2961244882426, 2765.612814206013, 2767.750902418792, 2775.4449110178043, 4819.108464933998, 4825.227963525819, 4825.9758701206265, 4828.589569886599, 4841.927371089437, 5070.847874563769, 5251.8161864335325, 5253.028189784902, 5287.841364759063, 5291.735413229323, 4801.447833499193, 4816.903661926812, 4819.614430845524, 4822.107910036654, 4836.298736683161, 5117.257997590403, 5125.410577783603, 5131.435542090442, 5171.120909445479, 5172.844814655567, 4869.391326084239, 4943.826966056171, 4988.725620090785, 5044.293798868088, 5048.899022019613, 4781.354517140281, 4794.544518270759, 4799.544043315879, 4800.879978000578, 4829.203181475017, 3657.7139287945033, 3667.706583473369, 3676.540432445944, 3690.1697118148204, 3693.5937046924278, 5041.6470847040355, 5112.130937740668, 5174.7153906535505, 5193.506616871391, 5211.322528071327, 4917.114919314415, 4945.0, 4969.82605608802, 4987.501249874984, 5007.37407824022, 4880.80476780939, 4932.950670493249, 5025.84922452327, 5030.748462576929, 5038.647294689336, 4628.9537104628525, 4908.239222920453, 4930.605551555938, 4952.925706114339, 4962.429320628174, 4869.829555965524, 4994.751312171957, 5016.774245158904, 5020.824271150492, 5022.748862556785, 4918.622785620032, 4925.21196608541, 4938.901221975612, 4991.301217829434, 5013.2981382607195], "value": 3769.6227832325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.7947137708867, 624.712632189193, 688.4320435640597, 716.4411758828114, 718.1669263654162, 12669.936650316748, 13781.86218137817, 13785.517506887261, 13785.724285514283, 13832.723345533082, 11314.773704525925, 12996.61010169694, 13000.869991300084, 13088.73822523549, 13185.472581096745, 768.627215800335, 780.1808101493438, 784.145281643009, 785.0696924144878, 785.7524879662916, 769.3268390158611, 769.6882762481204, 770.4144849914078, 770.452978385347, 774.0324594257179, 822.5681517203457, 823.3824631526355, 829.601791140253, 830.8795224692416, 830.9958450207771, 806.753940048285, 811.5414790643297, 812.5287333346645, 812.9756107316731, 813.3046245460135, 599.1043390131738, 600.7747094839435, 602.105872778923, 602.6022824935521, 603.3423568310519, 11604.6518604442, 11776.88223117775, 11796.410179490991, 11855.170138090338, 11875.16873818833, 10979.0, 11090.722731931686, 11225.775484490265, 11358.148138889534, 11563.884361156364, 9815.36200146988, 9872.0, 9954.950225248827, 9975.301728878982, 10023.44871032093, 3239.8542065607103, 3287.96712032879, 3307.2889328794427, 3321.3025264694443, 3417.5898892132855, 41925.580744192775, 57317.0, 58845.117323240185, 60346.396536034954, 61273.693631532005, 10863.40251286171, 10903.890961090447, 10982.231243812856, 11051.447427628586, 11132.888671113347, 13872.653183670287, 17278.30886764515, 17985.1007449627, 19798.40604781859, 19817.702734458995, 7005.474589405815, 7074.893876591856, 7088.610126443095, 7151.177614574286, 7511.737089201852, 3563.3051554947056, 3631.5279013728045, 3720.8325625346924, 3809.1810260794064, 3887.1448281378052, 2844.630198074237, 3003.9549406758915, 3005.248687828043, 3005.5040918248246, 3008.458477474032, 497.524863755113, 521.8643152780229, 522.8954209158184, 524.0645447875523, 527.5805734441052, 489.963726717996, 504.364500729084, 544.4501053935475, 550.4440515079798, 587.8853623543454, 8092.473989190684, 8197.590120493951, 8228.341732661493, 8339.24946754795, 8396.79008024792, 568.2385603291609, 586.8092869817241, 629.3580547841268, 641.2721561028173, 656.5305806348389, 3728.447094810384, 3780.771109803878, 3860.517435320585, 3916.1776027034643, 3963.504561929759, 84038.27693784483, 93495.53252233696, 93649.0, 94141.5292923531, 94663.0, 78987.60506197432, 79068.0, 79173.60413198013, 82055.17944820476, 82199.0, 41540.58459415367, 55196.89606207854, 55679.721601391735, 72682.27317726755, 72701.27298727051, 7485.214052524624, 7577.659005344883, 7679.155292917663, 7713.6143192841255, 7845.333146682367, 42897.35653965255, 43636.56363436452, 43955.34066989062, 44170.77914610406, 44178.01198946119, 57888.710556446946, 63338.683306583174, 63420.0, 63477.36522634899, 63813.3618663826, 9367.391119577205, 9567.186789123003, 9581.185599224144, 9601.855972160563, 9779.902200978184, 10699.89300106989, 10773.138148947908, 10997.12023038171, 11054.944725276322, 11098.50056747432, 10268.743281418025, 10798.568057277935, 10839.0, 11049.0, 11619.535218591162, 11981.772916780461, 12150.513979440724, 12233.694157645774, 12311.0, 12546.623601291976, 11039.116870650489, 11304.434778261219, 11647.41762911868, 11736.471858766547, 12672.936635316764, 9668.806623867624, 9989.800203996025, 10248.436336001294, 10299.53652085673, 10448.268621196747, 10207.387556746618, 10243.795124097625, 10456.68629941103, 10565.0, 10652.520636571218], "value": 6377.693930009743, "unit": "score"}], "name": "dromaeo_css", "value": 6270.637039217437, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 112.0, 113.0, 112.0, 113.0, 114.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 138.0, 142.0, 186.0, 140.0, 163.0, 159.0, 134.0, 191.0, 130.0], "value": 154.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 162.0, 164.0, 163.0, 164.0, 165.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 108.0, 75.0, 77.0, 75.0, 75.0, 98.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 130.0, 87.0, 87.0, 85.0, 122.0, 86.0, 86.0, 138.0], "value": 99.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 145.0, 146.0, 147.0, 148.0, 145.0, 146.0, 145.0, 147.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 67.0, 65.0, 66.0, 65.0, 67.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 67.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 83.0, 82.0, 87.0, 83.0, 83.0, 84.0, 91.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 134.0, 141.0, 140.0, 133.0, 127.0, 130.0, 129.0, 139.0, 134.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 167.0, 168.0, 168.0, 167.0, 172.0, 173.0, 169.0, 166.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 68.0, 68.0, 66.0, 67.0, 69.0, 68.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1555.7, "alertThreshold": 2.0}]} 01:07:25 INFO - Return code: 0 01:07:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:07:25 INFO - # TBPL SUCCESS # 01:07:25 INFO - Running post-action listener: _resource_record_post_action 01:07:25 INFO - ##### 01:07:25 INFO - ##### Finished run-tests step (success) 01:07:25 INFO - ##### 01:07:25 INFO - Running post-run listener: _resource_record_post_run 01:07:25 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543051776; Read time: 16; Write time: 646080 01:07:25 INFO - TinderboxPrint: CPU usage
13.2% 01:07:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:07:25 INFO - TinderboxPrint: I/O write bytes / time
543,051,776 / 646,080 01:07:25 INFO - TinderboxPrint: CPU idle
8,334.7 (86.8%) 01:07:25 INFO - TinderboxPrint: CPU user
1,216.5 (12.7%) 01:07:25 INFO - TinderboxPrint: Swap in / out
0 / 0 01:07:25 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 246652928; Read time: 0; Write time: 397940 01:07:25 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296398848; Read time: 16; Write time: 248140 01:07:26 INFO - Running post-run listener: _upload_blobber_files 01:07:26 INFO - Blob upload gear active. 01:07:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:07:26 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 01:07:26 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:07:26 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:07:26 INFO - (blobuploader) - INFO - Open directory for files ... 01:07:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:07:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:07:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:07:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:07:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:07:30 INFO - (blobuploader) - INFO - Done attempting. 01:07:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:07:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:07:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:07:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:07:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:07:31 INFO - (blobuploader) - INFO - Done attempting. 01:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:07:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:07:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:07:31 INFO - (blobuploader) - INFO - Done attempting. 01:07:31 INFO - (blobuploader) - INFO - Iteration through files over. 01:07:31 INFO - Return code: 0 01:07:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:07:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:07:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70cc96fcac2ce18b520af8d188bf3156e25890ab09ef907742c1674113d93cf28089ea057382a022172d033e6738a5f680aebece89ddbe8e5f35205f057b4f63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6efe7ca8054cb4735845261851a8535cba5c638636371c7adba6c5c32feed6f48d3a1ecf8cad7a8935e9e4fb2dd92dc8a83b26ef6bc6028794f6008816bc5ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea5774050131114056dc4833aae54098622da5b4e9e2f1e0787c159845857e499d6b92cfbd58e5c2564f7dd0b36194e9dab449c525ee5f9b434c6abf25209a2d"} 01:07:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:07:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:07:31 INFO - Contents: 01:07:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70cc96fcac2ce18b520af8d188bf3156e25890ab09ef907742c1674113d93cf28089ea057382a022172d033e6738a5f680aebece89ddbe8e5f35205f057b4f63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6efe7ca8054cb4735845261851a8535cba5c638636371c7adba6c5c32feed6f48d3a1ecf8cad7a8935e9e4fb2dd92dc8a83b26ef6bc6028794f6008816bc5ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea5774050131114056dc4833aae54098622da5b4e9e2f1e0787c159845857e499d6b92cfbd58e5c2564f7dd0b36194e9dab449c525ee5f9b434c6abf25209a2d"} 01:07:31 INFO - Running post-run listener: copy_logs_to_upload_dir 01:07:31 INFO - Copying logs to upload dir... 01:07:31 INFO - mkdir: /builds/slave/test/build/upload/logs 01:07:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.701101 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-24 01:07:30.975880) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 01:07:30.979557) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862 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-Non-PGO/sha512/70cc96fcac2ce18b520af8d188bf3156e25890ab09ef907742c1674113d93cf28089ea057382a022172d033e6738a5f680aebece89ddbe8e5f35205f057b4f63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6efe7ca8054cb4735845261851a8535cba5c638636371c7adba6c5c32feed6f48d3a1ecf8cad7a8935e9e4fb2dd92dc8a83b26ef6bc6028794f6008816bc5ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea5774050131114056dc4833aae54098622da5b4e9e2f1e0787c159845857e499d6b92cfbd58e5c2564f7dd0b36194e9dab449c525ee5f9b434c6abf25209a2d"} build_url:https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/aB0bcmmdR3elU_b_CxlGCA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70cc96fcac2ce18b520af8d188bf3156e25890ab09ef907742c1674113d93cf28089ea057382a022172d033e6738a5f680aebece89ddbe8e5f35205f057b4f63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6efe7ca8054cb4735845261851a8535cba5c638636371c7adba6c5c32feed6f48d3a1ecf8cad7a8935e9e4fb2dd92dc8a83b26ef6bc6028794f6008816bc5ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea5774050131114056dc4833aae54098622da5b4e9e2f1e0787c159845857e499d6b92cfbd58e5c2564f7dd0b36194e9dab449c525ee5f9b434c6abf25209a2d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 01:07:31.006010) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:07:31.006416) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466740043.611489-293901862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:07:31.092494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 01:07:31.092879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 01:07:31.093299) ========= ========= Total master_lag: 0.17 =========