builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1466582318.95 results: success (0) buildid: 20160622000716 builduid: 362ce1e45b0d45f6bb162cfd180003ea revision: 0d361d105c86ff3443c06a7387b994d75035178e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:38.947745) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:38.948300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:38.948681) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:38.983528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:38.983972) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 00:58:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 14.8M=0.001s 2016-06-22 00:58:39 (14.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179104 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.186954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.187426) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004312 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.245642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.246061) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0d361d105c86ff3443c06a7387b994d75035178e --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 0d361d105c86ff3443c06a7387b994d75035178e --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=56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 00:58:39,366 truncating revision to first 12 chars 2016-06-22 00:58:39,366 Setting DEBUG logging. 2016-06-22 00:58:39,366 attempt 1/10 2016-06-22 00:58:39,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0d361d105c86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 00:58:39,679 unpacking tar archive at: fx-team-0d361d105c86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648415 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.909547) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.909899) ========= script_repo_revision: 0d361d105c86ff3443c06a7387b994d75035178e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.910443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.910769) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 00:58:39.923242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-22 00:58:39.923706) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:58:40 INFO - MultiFileLogger online at 20160622 00:58:40 in /builds/slave/test 00:58:40 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:58:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:58:40 INFO - {'append_to_log': False, 00:58:40 INFO - 'base_work_dir': '/builds/slave/test', 00:58:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:58:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:58:40 INFO - 'branch': 'Fx-Team-Non-PGO', 00:58:40 INFO - 'buildbot_json_path': 'buildprops.json', 00:58:40 INFO - 'config_files': ('talos/linux_config.py',), 00:58:40 INFO - 'default_actions': ('clobber', 00:58:40 INFO - 'read-buildbot-config', 00:58:40 INFO - 'download-and-extract', 00:58:40 INFO - 'populate-webroot', 00:58:40 INFO - 'create-virtualenv', 00:58:40 INFO - 'install', 00:58:40 INFO - 'run-tests'), 00:58:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:58:40 INFO - 'download_minidump_stackwalk': True, 00:58:40 INFO - 'download_symbols': 'ondemand', 00:58:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:58:40 INFO - 'tooltool.py': '/tools/tooltool.py', 00:58:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:58:40 INFO - '/tools/misc-python/virtualenv.py')}, 00:58:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:58:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:58:40 INFO - 'installer_path': 'installer.exe', 00:58:40 INFO - 'log_level': 'info', 00:58:40 INFO - 'log_name': 'talos', 00:58:40 INFO - 'log_to_console': True, 00:58:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:58:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:58:40 INFO - 'opt_config_files': (), 00:58:40 INFO - 'pip_index': False, 00:58:40 INFO - 'sps_profile': False, 00:58:40 INFO - 'sps_profile_interval': 0, 00:58:40 INFO - 'suite': 'dromaeojs', 00:58:40 INFO - 'system_bits': '32', 00:58:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:58:40 INFO - 'title': 'talos-linux64-ix-037', 00:58:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:58:40 INFO - 'use_talos_json': True, 00:58:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:58:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:58:40 INFO - 'work_dir': 'build'} 00:58:40 INFO - ##### 00:58:40 INFO - ##### Running clobber step. 00:58:40 INFO - ##### 00:58:40 INFO - Running pre-action listener: _resource_record_pre_action 00:58:40 INFO - Running main action method: clobber 00:58:40 INFO - rmtree: /builds/slave/test/build 00:58:40 INFO - Running post-action listener: _resource_record_post_action 00:58:40 INFO - ##### 00:58:40 INFO - ##### Finished clobber step (success) 00:58:40 INFO - ##### 00:58:40 INFO - ##### 00:58:40 INFO - ##### Running read-buildbot-config step. 00:58:40 INFO - ##### 00:58:40 INFO - Running pre-action listener: _resource_record_pre_action 00:58:40 INFO - Running main action method: read_buildbot_config 00:58:40 INFO - Using buildbot properties: 00:58:40 INFO - { 00:58:40 INFO - "project": "", 00:58:40 INFO - "product": "firefox", 00:58:40 INFO - "script_repo_revision": "production", 00:58:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:58:40 INFO - "repository": "", 00:58:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:58:40 INFO - "buildid": "20160622000716", 00:58:40 INFO - "pgo_build": "False", 00:58:40 INFO - "basedir": "/builds/slave/test", 00:58:40 INFO - "buildnumber": 3097, 00:58:40 INFO - "slavename": "talos-linux64-ix-037", 00:58:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:58:40 INFO - "platform": "ubuntu64_hw", 00:58:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:58:40 INFO - "branch": "fx-team", 00:58:40 INFO - "repo_path": "integration/fx-team", 00:58:40 INFO - "revision": "0d361d105c86ff3443c06a7387b994d75035178e", 00:58:40 INFO - "stage_platform": "linux64", 00:58:40 INFO - "builduid": "362ce1e45b0d45f6bb162cfd180003ea", 00:58:40 INFO - "slavebuilddir": "test" 00:58:40 INFO - } 00:58:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:58:40 INFO - Running post-action listener: _resource_record_post_action 00:58:40 INFO - ##### 00:58:40 INFO - ##### Finished read-buildbot-config step (success) 00:58:40 INFO - ##### 00:58:40 INFO - ##### 00:58:40 INFO - ##### Running download-and-extract step. 00:58:40 INFO - ##### 00:58:40 INFO - Running pre-action listener: _resource_record_pre_action 00:58:40 INFO - Running main action method: download_and_extract 00:58:40 INFO - mkdir: /builds/slave/test/build/tests 00:58:40 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:58:40 INFO - https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/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:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/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:58:40 INFO - Downloaded 1361 bytes. 00:58:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:58:40 INFO - Using the following test package requirements: 00:58:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:58:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:58:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:58:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:40 INFO - u'jsshell-linux-x86_64.zip'], 00:58:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:58:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:58:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:58:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:58:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:58:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:58:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:58:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:58:40 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:58:40 INFO - https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/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:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/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:58:41 INFO - Downloaded 22701903 bytes. 00:58:41 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:58:41 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:58:43 INFO - Return code: 0 00:58:43 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:58:43 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:58:43 INFO - https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:58:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:58:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:58:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/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:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/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:58:45 INFO - Downloaded 22701903 bytes. 00:58:45 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:58:45 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:58:47 INFO - Return code: 0 00:58:47 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:58:47 INFO - https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:58:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:58:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:58:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/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:58:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/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:58:48 INFO - Downloaded 14405384 bytes. 00:58:48 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:58:48 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:58:48 INFO - Return code: 0 00:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:48 INFO - https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:58:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:58:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:58:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/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:58:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BLqnhGGERs-u-BHq1fGjXA/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:58:49 INFO - Downloaded 56236599 bytes. 00:58:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:58:49 INFO - mkdir: /builds/slave/test/properties 00:58:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:58:49 INFO - Writing to file /builds/slave/test/properties/build_url 00:58:49 INFO - Contents: 00:58:49 INFO - build_url:https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:58:50 INFO - Running post-action listener: _resource_record_post_action 00:58:50 INFO - Running post-action listener: set_extra_try_arguments 00:58:50 INFO - ##### 00:58:50 INFO - ##### Finished download-and-extract step (success) 00:58:50 INFO - ##### 00:58:50 INFO - ##### 00:58:50 INFO - ##### Running populate-webroot step. 00:58:50 INFO - ##### 00:58:50 INFO - Running pre-action listener: _resource_record_pre_action 00:58:50 INFO - Running main action method: populate_webroot 00:58:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:58:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:58:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:58:50 INFO - '--tppagecycles', 00:58:50 INFO - '7'], 00:58:50 INFO - 'tests': ['tsvgm']}}, 00:58:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:58:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:58:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:58:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:58:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:50 INFO - 'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:58:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:58:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:50 INFO - 'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['damp', 'tps']}, 00:58:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:50 INFO - 'tests': ['damp', 'tps']}, 00:58:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['dromaeo_dom']}, 00:58:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:58:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['basic_compositor_video']}, 00:58:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:58:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['a11yr', 00:58:50 INFO - 'ts_paint', 00:58:50 INFO - 'tpaint', 00:58:50 INFO - 'sessionrestore', 00:58:50 INFO - 'sessionrestore_no_auto_restore', 00:58:50 INFO - 'tabpaint']}, 00:58:50 INFO - 'other-e10s': {'tests': ['a11yr', 00:58:50 INFO - 'ts_paint', 00:58:50 INFO - 'tpaint', 00:58:50 INFO - 'sessionrestore', 00:58:50 INFO - 'sessionrestore_no_auto_restore', 00:58:50 INFO - 'tabpaint']}, 00:58:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:58:50 INFO - 'ts_paint', 00:58:50 INFO - 'tpaint', 00:58:50 INFO - 'sessionrestore', 00:58:50 INFO - 'sessionrestore_no_auto_restore', 00:58:50 INFO - 'tabpaint']}, 00:58:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:58:50 INFO - 'ts_paint', 00:58:50 INFO - 'tpaint', 00:58:50 INFO - 'sessionrestore', 00:58:50 INFO - 'sessionrestore_no_auto_restore', 00:58:50 INFO - 'tabpaint']}, 00:58:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['a11yr', 00:58:50 INFO - 'ts_paint', 00:58:50 INFO - 'tpaint', 00:58:50 INFO - 'sessionrestore', 00:58:50 INFO - 'sessionrestore_no_auto_restore', 00:58:50 INFO - 'tabpaint']}, 00:58:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['a11yr', 00:58:50 INFO - 'ts_paint', 00:58:50 INFO - 'tpaint', 00:58:50 INFO - 'sessionrestore', 00:58:50 INFO - 'sessionrestore_no_auto_restore', 00:58:50 INFO - 'tabpaint']}, 00:58:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['tsvgx', 00:58:50 INFO - 'tsvgr_opacity', 00:58:50 INFO - 'tart', 00:58:50 INFO - 'tscrollx', 00:58:50 INFO - 'cart']}, 00:58:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:58:50 INFO - 'tsvgr_opacity', 00:58:50 INFO - 'tart', 00:58:50 INFO - 'tscrollx', 00:58:50 INFO - 'cart']}, 00:58:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:50 INFO - 'talos_options': ['--disable-e10s'], 00:58:50 INFO - 'tests': ['tp5o']}, 00:58:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:50 INFO - 'tests': ['tp5o']}, 00:58:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:50 INFO - 'talos_options': ['--disable-e10s', 00:58:50 INFO - '--xperf_path', 00:58:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:58:50 INFO - 'tests': ['tp5n']}, 00:58:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:50 INFO - 'talos_options': ['--xperf_path', 00:58:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:58:50 INFO - 'tests': ['tp5n']}}, 00:58:50 INFO - 'talos.zip': {'path': '', 00:58:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:58:50 INFO - Running post-action listener: _resource_record_post_action 00:58:50 INFO - ##### 00:58:50 INFO - ##### Finished populate-webroot step (success) 00:58:50 INFO - ##### 00:58:50 INFO - ##### 00:58:50 INFO - ##### Running create-virtualenv step. 00:58:50 INFO - ##### 00:58:50 INFO - Running pre-action listener: _resource_record_pre_action 00:58:50 INFO - Running main action method: create_virtualenv 00:58:50 INFO - Creating virtualenv /builds/slave/test/build/venv 00:58:50 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:58:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:58:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:58:50 INFO - Using real prefix '/usr' 00:58:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:58:51 INFO - Installing distribute.............................................................................................................................................................................................done. 00:58:53 INFO - Installing pip.................done. 00:58:53 INFO - Return code: 0 00:58:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:58: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:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:53 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 0x7f97edf9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1653350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', '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:58:53 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:58:53 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:58:53 INFO - Using env: {'DISPLAY': ':0', 00:58:53 INFO - 'HOME': '/home/cltbld', 00:58:53 INFO - 'LANG': 'en_US.UTF-8', 00:58:53 INFO - 'LANGUAGE': 'en_US:en', 00:58:53 INFO - 'LOGNAME': 'cltbld', 00:58:53 INFO - 'MAIL': '/var/mail/cltbld', 00:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:53 INFO - 'MOZ_NO_REMOTE': '1', 00:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:53 INFO - 'NO_EM_RESTART': '1', 00:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:53 INFO - 'PWD': '/builds/slave/test', 00:58:53 INFO - 'SHELL': '/bin/bash', 00:58:53 INFO - 'SHLVL': '1', 00:58:53 INFO - 'TERM': 'linux', 00:58:53 INFO - 'TMOUT': '86400', 00:58:53 INFO - 'USER': 'cltbld', 00:58:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:53 INFO - '_': '/tools/buildbot/bin/python'} 00:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:54 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:58:54 INFO - Cleaning up... 00:58:54 INFO - Return code: 0 00:58:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:58: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:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:54 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 0x7f97edf9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1653350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', '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:58:54 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:58:54 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:58:54 INFO - Using env: {'DISPLAY': ':0', 00:58:54 INFO - 'HOME': '/home/cltbld', 00:58:54 INFO - 'LANG': 'en_US.UTF-8', 00:58:54 INFO - 'LANGUAGE': 'en_US:en', 00:58:54 INFO - 'LOGNAME': 'cltbld', 00:58:54 INFO - 'MAIL': '/var/mail/cltbld', 00:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:54 INFO - 'MOZ_NO_REMOTE': '1', 00:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:54 INFO - 'NO_EM_RESTART': '1', 00:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:54 INFO - 'PWD': '/builds/slave/test', 00:58:54 INFO - 'SHELL': '/bin/bash', 00:58:54 INFO - 'SHLVL': '1', 00:58:54 INFO - 'TERM': 'linux', 00:58:54 INFO - 'TMOUT': '86400', 00:58:54 INFO - 'USER': 'cltbld', 00:58:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:54 INFO - '_': '/tools/buildbot/bin/python'} 00:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:54 INFO - Downloading/unpacking psutil>=3.1.1 00:58:54 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:58:54 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:58:54 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:58:54 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:58:54 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:58:54 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:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:58:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:58:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:58:57 INFO - Installing collected packages: psutil 00:58:57 INFO - Running setup.py install for psutil 00:58:57 INFO - building 'psutil._psutil_linux' extension 00:58:57 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:58:58 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:58:58 INFO - building 'psutil._psutil_posix' extension 00:58:58 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:58:58 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:58:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:58:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:58:58 INFO - Successfully installed psutil 00:58:58 INFO - Cleaning up... 00:58:58 INFO - Return code: 0 00:58:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:58 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 0x7f97edf9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1653350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', '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:58:58 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:58:58 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:58:58 INFO - Using env: {'DISPLAY': ':0', 00:58:58 INFO - 'HOME': '/home/cltbld', 00:58:58 INFO - 'LANG': 'en_US.UTF-8', 00:58:58 INFO - 'LANGUAGE': 'en_US:en', 00:58:58 INFO - 'LOGNAME': 'cltbld', 00:58:58 INFO - 'MAIL': '/var/mail/cltbld', 00:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:58 INFO - 'MOZ_NO_REMOTE': '1', 00:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:58 INFO - 'NO_EM_RESTART': '1', 00:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:58 INFO - 'PWD': '/builds/slave/test', 00:58:58 INFO - 'SHELL': '/bin/bash', 00:58:58 INFO - 'SHLVL': '1', 00:58:58 INFO - 'TERM': 'linux', 00:58:58 INFO - 'TMOUT': '86400', 00:58:58 INFO - 'USER': 'cltbld', 00:58:58 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:58 INFO - '_': '/tools/buildbot/bin/python'} 00:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:58:59 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:58:59 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:58:59 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:58:59 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:58:59 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:58:59 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:59:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:59:01 INFO - Installing collected packages: mozsystemmonitor 00:59:01 INFO - Running setup.py install for mozsystemmonitor 00:59:01 INFO - Successfully installed mozsystemmonitor 00:59:01 INFO - Cleaning up... 00:59:01 INFO - Return code: 0 00:59:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:01 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 0x7f97edf9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1653350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', '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:59:01 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:59:01 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:59:01 INFO - Using env: {'DISPLAY': ':0', 00:59:01 INFO - 'HOME': '/home/cltbld', 00:59:01 INFO - 'LANG': 'en_US.UTF-8', 00:59:01 INFO - 'LANGUAGE': 'en_US:en', 00:59:01 INFO - 'LOGNAME': 'cltbld', 00:59:01 INFO - 'MAIL': '/var/mail/cltbld', 00:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:01 INFO - 'MOZ_NO_REMOTE': '1', 00:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:01 INFO - 'NO_EM_RESTART': '1', 00:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:01 INFO - 'PWD': '/builds/slave/test', 00:59:01 INFO - 'SHELL': '/bin/bash', 00:59:01 INFO - 'SHLVL': '1', 00:59:01 INFO - 'TERM': 'linux', 00:59:01 INFO - 'TMOUT': '86400', 00:59:01 INFO - 'USER': 'cltbld', 00:59:01 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:01 INFO - '_': '/tools/buildbot/bin/python'} 00:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:01 INFO - Downloading/unpacking jsonschema==2.5.1 00:59:01 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:59:01 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:59:01 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:59:01 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:59:01 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:59:01 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:59:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:59:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:59:03 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:59:03 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:59:03 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:59:03 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:59:03 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:59:03 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:59:03 INFO - Downloading functools32-3.2.3-2.tar.gz 00:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:59:03 INFO - warning: no files found matching '*.txt' 00:59:03 INFO - no previously-included directories found matching 'build' 00:59:03 INFO - no previously-included directories found matching 'dist' 00:59:03 INFO - no previously-included directories found matching '.git*' 00:59:03 INFO - Installing collected packages: jsonschema, functools32 00:59:03 INFO - Running setup.py install for functools32 00:59:03 INFO - warning: no files found matching '*.txt' 00:59:03 INFO - no previously-included directories found matching 'build' 00:59:03 INFO - no previously-included directories found matching 'dist' 00:59:03 INFO - no previously-included directories found matching '.git*' 00:59:03 INFO - Successfully installed jsonschema functools32 00:59:03 INFO - Cleaning up... 00:59:03 INFO - Return code: 0 00:59:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:03 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 0x7f97edf9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1653350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', '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:59:03 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:59:03 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:59:03 INFO - Using env: {'DISPLAY': ':0', 00:59:03 INFO - 'HOME': '/home/cltbld', 00:59:03 INFO - 'LANG': 'en_US.UTF-8', 00:59:03 INFO - 'LANGUAGE': 'en_US:en', 00:59:03 INFO - 'LOGNAME': 'cltbld', 00:59:03 INFO - 'MAIL': '/var/mail/cltbld', 00:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:03 INFO - 'MOZ_NO_REMOTE': '1', 00:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:03 INFO - 'NO_EM_RESTART': '1', 00:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:03 INFO - 'PWD': '/builds/slave/test', 00:59:03 INFO - 'SHELL': '/bin/bash', 00:59:03 INFO - 'SHLVL': '1', 00:59:03 INFO - 'TERM': 'linux', 00:59:03 INFO - 'TMOUT': '86400', 00:59:03 INFO - 'USER': 'cltbld', 00:59:03 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:03 INFO - '_': '/tools/buildbot/bin/python'} 00:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:04 INFO - Downloading/unpacking blobuploader==1.2.4 00:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:05 INFO - Downloading blobuploader-1.2.4.tar.gz 00:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:59:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:59:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:06 INFO - Downloading docopt-0.6.1.tar.gz 00:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:59:06 INFO - Installing collected packages: blobuploader, requests, docopt 00:59:06 INFO - Running setup.py install for blobuploader 00:59:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:59:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:59:06 INFO - Running setup.py install for requests 00:59:07 INFO - Running setup.py install for docopt 00:59:07 INFO - Successfully installed blobuploader requests docopt 00:59:07 INFO - Cleaning up... 00:59:07 INFO - Return code: 0 00:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:59: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:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:07 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 0x7f97edf9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1653350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', '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:59:07 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:59:07 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:59:07 INFO - Using env: {'DISPLAY': ':0', 00:59:07 INFO - 'HOME': '/home/cltbld', 00:59:07 INFO - 'LANG': 'en_US.UTF-8', 00:59:07 INFO - 'LANGUAGE': 'en_US:en', 00:59:07 INFO - 'LOGNAME': 'cltbld', 00:59:07 INFO - 'MAIL': '/var/mail/cltbld', 00:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:07 INFO - 'MOZ_NO_REMOTE': '1', 00:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:07 INFO - 'NO_EM_RESTART': '1', 00:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:07 INFO - 'PWD': '/builds/slave/test', 00:59:07 INFO - 'SHELL': '/bin/bash', 00:59:07 INFO - 'SHLVL': '1', 00:59:07 INFO - 'TERM': 'linux', 00:59:07 INFO - 'TMOUT': '86400', 00:59:07 INFO - 'USER': 'cltbld', 00:59:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:07 INFO - '_': '/tools/buildbot/bin/python'} 00:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:59:07 INFO - Running setup.py (path:/tmp/pip-uZOPzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:59:07 INFO - Running setup.py (path:/tmp/pip-sdVPWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:59:07 INFO - Running setup.py (path:/tmp/pip-SbTxhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:59:07 INFO - Running setup.py (path:/tmp/pip-7nwfkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:59:07 INFO - Running setup.py (path:/tmp/pip-MYNKQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:59:07 INFO - Running setup.py (path:/tmp/pip-PmttP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:59:07 INFO - Running setup.py (path:/tmp/pip-uK1n4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:59:08 INFO - Running setup.py (path:/tmp/pip-TTJUHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:59:08 INFO - Running setup.py (path:/tmp/pip-70mrj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:59:08 INFO - Running setup.py (path:/tmp/pip-UhJcEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:59:08 INFO - Running setup.py (path:/tmp/pip-XkGa5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:59:08 INFO - Running setup.py (path:/tmp/pip-MV37fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:59:08 INFO - Running setup.py (path:/tmp/pip-N6APU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:59:08 INFO - Running setup.py (path:/tmp/pip-HQvi9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:08 INFO - Running setup.py (path:/tmp/pip-1_H1yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:59:08 INFO - Running setup.py (path:/tmp/pip-7ZFqUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:59:08 INFO - Running setup.py (path:/tmp/pip-slfLXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:59:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:59:08 INFO - Running setup.py install for manifestparser 00:59:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:59:08 INFO - Running setup.py install for mozcrash 00:59:08 INFO - Running setup.py install for mozdebug 00:59:09 INFO - Running setup.py install for mozdevice 00:59:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:59:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:59:09 INFO - Running setup.py install for mozfile 00:59:09 INFO - Running setup.py install for mozhttpd 00:59:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:59:09 INFO - Running setup.py install for mozinfo 00:59:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:59:09 INFO - Running setup.py install for mozInstall 00:59:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:59:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:59:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:59:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:59:09 INFO - Running setup.py install for mozleak 00:59:09 INFO - Running setup.py install for mozlog 00:59:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:59:09 INFO - Running setup.py install for moznetwork 00:59:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:59:09 INFO - Running setup.py install for mozprocess 00:59:10 INFO - Running setup.py install for mozprofile 00:59:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:59:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:59:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:59:10 INFO - Running setup.py install for mozrunner 00:59:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:59:10 INFO - Running setup.py install for mozscreenshot 00:59:10 INFO - Running setup.py install for moztest 00:59:10 INFO - Running setup.py install for mozversion 00:59:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:59:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:59:10 INFO - Cleaning up... 00:59:10 INFO - Return code: 0 00:59:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:10 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 0x7f97edf9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1653350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', '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:59:10 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:59:10 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:59:10 INFO - Using env: {'DISPLAY': ':0', 00:59:10 INFO - 'HOME': '/home/cltbld', 00:59:10 INFO - 'LANG': 'en_US.UTF-8', 00:59:10 INFO - 'LANGUAGE': 'en_US:en', 00:59:10 INFO - 'LOGNAME': 'cltbld', 00:59:10 INFO - 'MAIL': '/var/mail/cltbld', 00:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:10 INFO - 'MOZ_NO_REMOTE': '1', 00:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:10 INFO - 'NO_EM_RESTART': '1', 00:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:10 INFO - 'PWD': '/builds/slave/test', 00:59:10 INFO - 'SHELL': '/bin/bash', 00:59:10 INFO - 'SHLVL': '1', 00:59:10 INFO - 'TERM': 'linux', 00:59:10 INFO - 'TMOUT': '86400', 00:59:10 INFO - 'USER': 'cltbld', 00:59:10 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:10 INFO - '_': '/tools/buildbot/bin/python'} 00:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:59:10 INFO - Running setup.py (path:/tmp/pip-4kRGx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:59:10 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:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:59:10 INFO - Running setup.py (path:/tmp/pip-K6HS9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:59:10 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:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:59:10 INFO - Running setup.py (path:/tmp/pip-4hStI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:59:11 INFO - Running setup.py (path:/tmp/pip-jM5lCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:59:11 INFO - Running setup.py (path:/tmp/pip-rGRkYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:59:11 INFO - Running setup.py (path:/tmp/pip-14FioE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:59:11 INFO - Running setup.py (path:/tmp/pip-JIvNid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:59:11 INFO - Running setup.py (path:/tmp/pip-FBbn6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:59:11 INFO - Running setup.py (path:/tmp/pip-IralMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:59:11 INFO - Running setup.py (path:/tmp/pip-RHJdhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:59:11 INFO - Running setup.py (path:/tmp/pip-vcYK5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:59:11 INFO - Running setup.py (path:/tmp/pip-k3ruH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:59:11 INFO - Running setup.py (path:/tmp/pip-VWDMrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:59:11 INFO - Running setup.py (path:/tmp/pip-fmNT5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:11 INFO - Running setup.py (path:/tmp/pip-pay0M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:59:11 INFO - Running setup.py (path:/tmp/pip-NyzP0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:59:11 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:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:59:11 INFO - Running setup.py (path:/tmp/pip-2qoq7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:59:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:13 INFO - Downloading blessings-1.6.tar.gz 00:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:59:13 INFO - Installing collected packages: blessings 00:59:13 INFO - Running setup.py install for blessings 00:59:14 INFO - Successfully installed blessings 00:59:14 INFO - Cleaning up... 00:59:14 INFO - Return code: 0 00:59:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:59:14 INFO - Reading from file tmpfile_stdout 00:59:14 INFO - Current package versions: 00:59:14 INFO - argparse == 1.2.1 00:59:14 INFO - blessings == 1.6 00:59:14 INFO - blobuploader == 1.2.4 00:59:14 INFO - docopt == 0.6.1 00:59:14 INFO - functools32 == 3.2.3-2 00:59:14 INFO - jsonschema == 2.5.1 00:59:14 INFO - manifestparser == 1.1 00:59:14 INFO - mozInstall == 1.12 00:59:14 INFO - mozcrash == 0.17 00:59:14 INFO - mozdebug == 0.1 00:59:14 INFO - mozdevice == 0.48 00:59:14 INFO - mozfile == 1.2 00:59:14 INFO - mozhttpd == 0.7 00:59:14 INFO - mozinfo == 0.9 00:59:14 INFO - mozleak == 0.1 00:59:14 INFO - mozlog == 3.2 00:59:14 INFO - moznetwork == 0.27 00:59:14 INFO - mozprocess == 0.22 00:59:14 INFO - mozprofile == 0.28 00:59:14 INFO - mozrunner == 6.11 00:59:14 INFO - mozscreenshot == 0.1 00:59:14 INFO - mozsystemmonitor == 0.3 00:59:14 INFO - moztest == 0.7 00:59:14 INFO - mozversion == 1.4 00:59:14 INFO - psutil == 3.1.1 00:59:14 INFO - requests == 1.2.3 00:59:14 INFO - wsgiref == 0.1.2 00:59:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:59: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:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:14 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 0x7f97edf9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1653350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', '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:59:14 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:59:14 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:59:14 INFO - Using env: {'DISPLAY': ':0', 00:59:14 INFO - 'HOME': '/home/cltbld', 00:59:14 INFO - 'LANG': 'en_US.UTF-8', 00:59:14 INFO - 'LANGUAGE': 'en_US:en', 00:59:14 INFO - 'LOGNAME': 'cltbld', 00:59:14 INFO - 'MAIL': '/var/mail/cltbld', 00:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:14 INFO - 'MOZ_NO_REMOTE': '1', 00:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:14 INFO - 'NO_EM_RESTART': '1', 00:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:14 INFO - 'PWD': '/builds/slave/test', 00:59:14 INFO - 'SHELL': '/bin/bash', 00:59:14 INFO - 'SHLVL': '1', 00:59:14 INFO - 'TERM': 'linux', 00:59:14 INFO - 'TMOUT': '86400', 00:59:14 INFO - 'USER': 'cltbld', 00:59:14 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:14 INFO - '_': '/tools/buildbot/bin/python'} 00:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 INFO - Cleaning up... 00:59:14 INFO - Return code: 0 00:59:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:59: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:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:14 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 0x7f97edf9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1653350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', '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:59:14 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:59:14 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:59:14 INFO - Using env: {'DISPLAY': ':0', 00:59:14 INFO - 'HOME': '/home/cltbld', 00:59:14 INFO - 'LANG': 'en_US.UTF-8', 00:59:14 INFO - 'LANGUAGE': 'en_US:en', 00:59:14 INFO - 'LOGNAME': 'cltbld', 00:59:14 INFO - 'MAIL': '/var/mail/cltbld', 00:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:14 INFO - 'MOZ_NO_REMOTE': '1', 00:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:14 INFO - 'NO_EM_RESTART': '1', 00:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:14 INFO - 'PWD': '/builds/slave/test', 00:59:14 INFO - 'SHELL': '/bin/bash', 00:59:14 INFO - 'SHLVL': '1', 00:59:14 INFO - 'TERM': 'linux', 00:59:14 INFO - 'TMOUT': '86400', 00:59:14 INFO - 'USER': 'cltbld', 00:59:14 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:14 INFO - '_': '/tools/buildbot/bin/python'} 00:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:59:14 INFO - Cleaning up... 00:59:14 INFO - Return code: 0 00:59:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:59: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:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:14 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 0x7f97edf9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1653350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', '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:59:14 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:59:14 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:59:14 INFO - Using env: {'DISPLAY': ':0', 00:59:14 INFO - 'HOME': '/home/cltbld', 00:59:14 INFO - 'LANG': 'en_US.UTF-8', 00:59:14 INFO - 'LANGUAGE': 'en_US:en', 00:59:14 INFO - 'LOGNAME': 'cltbld', 00:59:14 INFO - 'MAIL': '/var/mail/cltbld', 00:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:14 INFO - 'MOZ_NO_REMOTE': '1', 00:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:14 INFO - 'NO_EM_RESTART': '1', 00:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:14 INFO - 'PWD': '/builds/slave/test', 00:59:14 INFO - 'SHELL': '/bin/bash', 00:59:14 INFO - 'SHLVL': '1', 00:59:14 INFO - 'TERM': 'linux', 00:59:14 INFO - 'TMOUT': '86400', 00:59:14 INFO - 'USER': 'cltbld', 00:59:14 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:14 INFO - '_': '/tools/buildbot/bin/python'} 00:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:15 INFO - Downloading/unpacking flake8 00:59: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:59: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:59: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:59: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:59: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:59: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:59:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:59:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:59:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:59:17 INFO - no previously-included directories found matching 'docs/_build' 00:59:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:59:17 INFO - Running setup.py install for pep8 00:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:59:17 INFO - no previously-included directories found matching 'docs/_build' 00:59:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:59:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:59:17 INFO - Cleaning up... 00:59:17 INFO - Return code: 0 00:59:17 INFO - Running post-action listener: _resource_record_post_action 00:59:17 INFO - Running post-action listener: _start_resource_monitoring 00:59:17 INFO - Starting resource monitoring. 00:59:17 INFO - ##### 00:59:17 INFO - ##### Finished create-virtualenv step (success) 00:59:17 INFO - ##### 00:59:17 INFO - ##### 00:59:17 INFO - ##### Running install step. 00:59:17 INFO - ##### 00:59:17 INFO - Running pre-action listener: _resource_record_pre_action 00:59:17 INFO - Running main action method: install 00:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:59:18 INFO - Reading from file tmpfile_stdout 00:59:18 INFO - Detecting whether we're running mozinstall >=1.0... 00:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:59:18 INFO - Reading from file tmpfile_stdout 00:59:18 INFO - Output received: 00:59:18 INFO - Usage: mozinstall [options] installer 00:59:18 INFO - Options: 00:59:18 INFO - -h, --help show this help message and exit 00:59:18 INFO - -d DEST, --destination=DEST 00:59:18 INFO - Directory to install application into. [default: 00:59:18 INFO - "/builds/slave/test"] 00:59:18 INFO - --app=APP Application being installed. [default: firefox] 00:59:18 INFO - mkdir: /builds/slave/test/build/application 00:59:18 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:59:18 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:59:34 INFO - Reading from file tmpfile_stdout 00:59:34 INFO - Output received: 00:59:34 INFO - /builds/slave/test/build/application/firefox/firefox 00:59:34 INFO - Running post-action listener: _resource_record_post_action 00:59:34 INFO - ##### 00:59:34 INFO - ##### Finished install step (success) 00:59:34 INFO - ##### 00:59:34 INFO - ##### 00:59:34 INFO - ##### Running run-tests step. 00:59:34 INFO - ##### 00:59:34 INFO - Running pre-action listener: _resource_record_pre_action 00:59:34 INFO - Running main action method: run_tests 00:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:59:34 INFO - Python 2.7.3 00:59:34 INFO - Return code: 0 00:59:34 INFO - grabbing minidump binary from tooltool 00:59:34 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:59:34 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 0x16e21c0>, '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 0x16e30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:59:34 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:59:34 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:59:34 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:59:34 INFO - INFO - File linux64-minidump_stackwalk not present in local cache folder /builds/tooltool_cache 00:59:34 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 00:59:35 INFO - INFO - File linux64-minidump_stackwalk fetched from https://api.pub.build.mozilla.org/tooltool/ as /builds/slave/test/build/tmp61wxoy 00:59:35 INFO - INFO - File integrity verified, renaming tmp61wxoy to linux64-minidump_stackwalk 00:59:35 INFO - INFO - Updating local cache /builds/tooltool_cache... 00:59:35 INFO - INFO - Local cache /builds/tooltool_cache updated with linux64-minidump_stackwalk 00:59:35 INFO - Return code: 0 00:59:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:59:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:59:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:59:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:59:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:59:36 INFO - Return code: 0 00:59:36 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/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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:59:36 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/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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:59:36 INFO - Using env: {'DISPLAY': ':0', 00:59:36 INFO - 'HOME': '/home/cltbld', 00:59:36 INFO - 'LANG': 'en_US.UTF-8', 00:59:36 INFO - 'LANGUAGE': 'en_US:en', 00:59:36 INFO - 'LOGNAME': 'cltbld', 00:59:36 INFO - 'MAIL': '/var/mail/cltbld', 00:59:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:59:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:36 INFO - 'MOZ_NO_REMOTE': '1', 00:59:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:36 INFO - 'NO_EM_RESTART': '1', 00:59:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:36 INFO - 'PWD': '/builds/slave/test', 00:59:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:59:36 INFO - 'SHELL': '/bin/bash', 00:59:36 INFO - 'SHLVL': '1', 00:59:36 INFO - 'TERM': 'linux', 00:59:36 INFO - 'TMOUT': '86400', 00:59:36 INFO - 'USER': 'cltbld', 00:59:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547', 00:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:36 INFO - '_': '/tools/buildbot/bin/python'} 00:59:36 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/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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:59:36 INFO - mozversion application_buildid: 20160622000716 00:59:36 INFO - mozversion application_changeset: 0d361d105c86ff3443c06a7387b994d75035178e 00:59:36 INFO - mozversion application_display_name: Nightly 00:59:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:59:36 INFO - mozversion application_name: Firefox 00:59:36 INFO - mozversion application_remotingname: firefox 00:59:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:59:36 INFO - mozversion application_vendor: Mozilla 00:59:36 INFO - mozversion application_version: 50.0a1 00:59:36 INFO - mozversion platform_buildid: 20160622000716 00:59:36 INFO - mozversion platform_changeset: 0d361d105c86ff3443c06a7387b994d75035178e 00:59:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:59:36 INFO - mozversion platform_version: 50.0a1 00:59:36 INFO - using testdate: 1466582376 00:59:36 INFO - actual date: 1466582376 00:59:36 INFO - starting webserver on 'localhost:52523' 00:59:36 INFO - SUITE-START | Running 2 tests 00:59:36 INFO - TEST-START | dromaeo_css 00:59:36 INFO - operating with platform_type : linux_ 00:59:36 INFO - Initialising browser for dromaeo_css test... 00:59:36 INFO - TEST-INFO | started process 3447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp726RZH/profile http://localhost:52523/getInfo.html) 00:59:42 INFO - PROCESS | 3447 | __metrics Screen width/height:1600/1200 00:59:42 INFO - PROCESS | 3447 | colorDepth:24 00:59:42 INFO - PROCESS | 3447 | Browser inner width/height: 1024/697 00:59:42 INFO - PROCESS | 3447 | __metrics 00:59:43 INFO - PROCESS | 3447 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:59:44 INFO - PROCESS | 3447 | console.error: PushService: 00:59:44 INFO - PROCESS | 3447 | stateChangeProcessEnqueue: Error transitioning state 00:59:44 INFO - PROCESS | 3447 | UnknownError 00:59:44 INFO - TEST-INFO | 3447: exit 0 00:59:44 INFO - Browser initialized. 00:59:44 INFO - Running cycle 1/1 for dromaeo_css test... 00:59:44 INFO - TEST-INFO | started process 3528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp726RZH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:59:56 INFO - PROCESS | 3528 | RSS: Main: 175599616 00:59:56 INFO - PROCESS | 3528 | 01:00:47 INFO - PROCESS | 3528 | 1466582447988 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] 01:03:01 INFO - PROCESS | 3528 | Cycle 1(1): loaded http://localhost:52523/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52523/tests/dromaeo/cssquery-ext.html) 01:03:02 INFO - PROCESS | 3528 | RSS: Main: 290603008 01:03:02 INFO - PROCESS | 3528 | 01:06:05 INFO - PROCESS | 3528 | Cycle 1(1): loaded http://localhost:52523/tests/dromaeo/cssquery-ext.html (next: http://localhost:52523/tests/dromaeo/cssquery-jquery.html) 01:06:05 INFO - PROCESS | 3528 | RSS: Main: 257757184 01:06:05 INFO - PROCESS | 3528 | 01:09:08 INFO - PROCESS | 3528 | Cycle 1(1): loaded http://localhost:52523/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52523/tests/dromaeo/cssquery-mootools.html) 01:09:08 INFO - PROCESS | 3528 | RSS: Main: 253550592 01:09:08 INFO - PROCESS | 3528 | 01:12:10 INFO - PROCESS | 3528 | Cycle 1(1): loaded http://localhost:52523/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52523/tests/dromaeo/cssquery-prototype.html) 01:12:11 INFO - PROCESS | 3528 | RSS: Main: 256651264 01:12:11 INFO - PROCESS | 3528 | 01:15:14 INFO - PROCESS | 3528 | Cycle 1(1): loaded http://localhost:52523/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52523/tests/dromaeo/cssquery-yui.html) 01:15:15 INFO - PROCESS | 3528 | RSS: Main: 229081088 01:15:15 INFO - PROCESS | 3528 | 01:18:18 INFO - PROCESS | 3528 | Cycle 1(1): loaded http://localhost:52523/tests/dromaeo/cssquery-yui.html (next: http://localhost:52523/tests/dromaeo/cssquery-dojo.html) 01:18:18 INFO - PROCESS | 3528 | RSS: Main: 289579008 01:18:18 INFO - PROCESS | 3528 | 01:18:18 INFO - PROCESS | 3528 | __start_tp_report 01:18:18 INFO - PROCESS | 3528 | _x_x_mozilla_page_load 01:18:18 INFO - PROCESS | 3528 | _x_x_mozilla_page_load_details 01:18:18 INFO - PROCESS | 3528 | |i|pagename|runs| 01:18:18 INFO - PROCESS | 3528 | |0;dojo.html;2672.4254285328657;2679.933001674959;2706.9187924362263;2712.471068141713;2715.891364345426;4703.882402939919;4765.809367625291;4776.713397196167;4912.582430493403;4944.4066711994565;4810.615150787938;4825.71045737256;4833.951660483394;4851.296561998517;4885.853424397274;4422.889427764299;4449.154660614473;4468.50846406895;4490.3040028795585;4544.977380089486;4430.9778451107695;4494.16857881293;4503.932441013371;4532.501424843264;4546.090781843628;4311.28863737483;4414.514403415622;4481.731096134243;4496.213162696547;4506.121306345264;4316.48202215733;4389.078293558325;4390.538993405678;4424.469063712343;4432.22436073689;4372.672049596293;4433;4454.933176002362;4469.10617876426;4497.820087196508;4689.50760170184;4859.684120532154;4874.195757699975;4920.581750551208;4937.703737775709;5138.58891288696;5193.065248255312;5195.272661827347;5275.815346462894;5279.947200527984;5258.237555554461;5264.315638966948;5293.57651387888;5295.0468915595175;5309.867253318698;4714.740689262055;4826;4948.356713627206;4951.405831300267;4952.182889823211;5295.364556253197;5338.91991620126;5356.1697936819855;5406.216098665672;5422.511973922287;5175.482451754794;5200.115980283361;5207.635465517453;5209.765560549784;5212.192110222922;4981.551660350586;5099;5147.459516750762;5205.45342739007;5263.842084737464;5114.105031619451;5131.153359695683;5135.4094279157625;5137.974310128426;5167.22491626259;5095.337606111182;5097.082525145435;5103.157978933508;5122.154844450624;5152.252923326097;4279.336702811007;4314.935275970863;4315.8489452869;4368.126374725068;4388.978055109704;3856.9035774105873;3874.5931677174053;3911.6675082618294;3959.3862951242604;3963.5441924178513;4467.441569803775;4467.463904331501;4471.709338893027;4473;4520.841770538082;4998.600111991032;5169.353830771153;5250.501202385767;5259.158534634516;5310.8141215057285;4426.756528390905;4454.064646424287;4472.39622650938;4514.616257618073;4520.434945631796;4690.554397332248;4700.130475861976;4701.083288758659;4705.811767529261;4750.976245118753;4682.0401817626625;4827.275908613736;4853.80584776605;4885.340479035356;4891.633127515522;5226.242194881797;5239.528442440199;5244.947550524446;5249.13389290778;5294.497022782984;4887.437944636412;4894.437139728977;4896.877578060435;4898.681585696918;4949.480304567968;4938.185199442052;5066.138756411346;5073.213651883964;5104.948950510596;5167.974160129175;5190.117679994485;5190.740462976761;5193.714345711022;5198;5213.76538055796;5049.166887463674;5052.1663925451885;5052.393712754493;5053.393592768891;5055.898882022412;4866;5015.899682006412;5041.319421878146;5072.4673909239;5082.593392528663;4956.628252881121;5019.949800501949;5061.772220250024;5065.214891691794;5068.569171620454;4953.3065370848835;5042.899142017212;5053.267276244997;5063.8480845574695;5085;4965.1807451770055;5006.4743201963265;5017.197248440232;5041.168207245763;5059.114654935445 01:18:18 INFO - PROCESS | 3528 | |1;ext.html;546.5262534836115;580.8722081142147;586.870888404551;593.6497466494767;603.1435361786262;26651.333716657093;39430.80284598577;40522.18955620886;40559.79720101399;44143.55856441434;39849.800750996204;40211.798941005254;40400.39399409011;40425.797871010676;40450.190996180056;7901.999999999985;7918.2477664621765;7971.322437592811;7989.520628762264;7994.800129996767;7795.766127016199;7869.685212591489;7894.250046245597;7896.447248692594;7899.802504937394;7938.24586664266;7976.920230797676;8019.398545109111;8021.518708877456;8022.19778022196;7952.681892724313;7968.44220904534;7997.760067197935;7997.920020799776;8003.599820009034;7934.246246606564;7981.321587665056;8003.399745019147;8006.599670016534;8008.079070906862;38491.80754096239;38598.614013859784;38635.22729545421;38645.613543864485;38683.41974870379;3113.8131712097347;3308.3217940322174;3332.683395077464;3441.776284541497;3501.1422201560526;29328.26679333034;29772.70227297721;30183.342794259785;30666.23334416635;31071.84464077688;3280.8687652493873;3313.5858017747782;3348.0123363607795;3355.328934213167;3413.1296519387647;181370;181388;181600;181646;183104.99999999866;27675.584866227022;28247.717522824507;28305.43389132206;51120;51937.48062519402;33893.322133557194;34113.829430853184;34114.48828267578;34123.4881476778;34155.316893662486;13176.341182940814;13257.138286011379;13257.270850103145;13260.403281852146;13270.203787772765;10891.074258687942;10919.181061420426;10919.672409827559;10920.836187457195;10928.125749939985;7930.206979302139;7941.324987376138;7942.920570794334;8000.319972802261;8008.079070906804;3108.673589273139;3148;3173.571567838312;3173.7302329301806;3206.2785873178814;813.9552324622202;843.9156084391511;888.8400637168428;954.651552183462;1013.7668336282696;26369.47261054768;27472;27618.171454856387;27686.307842304104;27722.445551088866;780.5043797188825;927.5269612497675;944.9935818353432;962.3552220012608;974.6101559376306;14324.283785810669;14572.271386430848;14811;14911.254437278092;15028.474003410047;374749;378081;380702;381273;382256;48115.5188448111;48560.5143948556;48615.27077093846;48705;48751.75624121928;1087.8313861351344;1161.5528021711532;1197.5209916033657;1214.6963259185204;1214.7995580729257;28019.159425217276;29402;29821;29874.551881722226;30009.399812004074;36547.26905461929;36576;36902.446463302535;36970.44544331891;37009.81495092507;295836;296527;297156;298401;538467;24798.876005619855;25479.49041019132;25508.489830203664;26715.465690685687;26725.599116012887;42228;42920.570794291656;43208.135837283706;44337.11325773402;48501.27248091352;36230;37264.44103338398;37597.248055039294;37687;37719.245615087;36417.27165456623;36515.817420912725;36600.63399366079;36745.08137296482;37090.814545927096;35677.46483802797;35835.64164358323;36210.8189459051;36497.45253821248;36699.44950825793;29508.114756557337;29911.55132673055;29999.100026999226;30360.696393035785;30392.544111838783;25283.771423430684;25810.741892580834;25905.611415829153;26112.73887261103;26352.736472635796 01:18:18 INFO - PROCESS | 3528 | |2;jquery.html;377.2379792818506;378.5495260639838;384.71531067010403;390.7948327128259;394.1093129527267;15614.86382443957;16915;17376.913115434436;17569.82430175698;17629.382971595966;15591.92204038981;16742.330306787713;17161.742573861404;17238.310467581283;17252.568685782862;4511.030128522367;4659.324397962293;4733.66864319496;4735.242361222206;4735.242361222206;3481.3733527964955;5118.692878427306;5417.566594672437;5419.078756611386;5487.396386397493;5377.973110134463;5450.182472629098;5465.863353416176;5483.8080667176655;5487.533559647435;5294.258803767476;5401.756920938567;5404.5946554008215;5409.594280428983;5475.589330800186;3368.6126095499085;4981.402231732179;5355.678659280456;5359.169328754049;5412.729363531807;11930.880691193064;12091.45588448522;12094.818577721342;17309.826901730947;20459.158675719256;1932.6424611446928;1988.453175376783;1999.2902519605475;2011.8491113166424;2023.4840115770385;8721.912780872173;9063.637454501812;9085.636574537011;9258.120478554527;9646.710598682052;1719.6216832296875;1728.888756254544;1740;1774.104077440884;1814.8185181481879;65868.6706566469;67871;68540;68763.65618171927;70304.64847675832;9837.754056148653;9927.553260103312;10205.285630005828;10252.58989640421;10974.615888443866;13809.51666691661;13884.444622214998;13968.511102111377;13970.650733731738;14017.5093871714;6790.660466976631;7057.576545407292;7173.6771845267085;7230.74692385764;7235.204127545966;6582.17722784652;6601.405873471411;6754;6773.491988100912;6773.559718618274;4354.608085272341;4441.822327106879;4455.598996090367;4527.275635898241;4583.9083218335445;1698.41404715373;1763.6560870630103;1830.304484295959;1834.4313262888547;1835.5227640813484;736.4108713029555;757.3903008078439;860.5783166248493;894.673444192865;910.0808183734343;15923.363065477251;16588.75116873248;16636.67086607876;16700.58248543796;16803.07583082942;833.795720048592;858.7037472072125;862.1766213266316;871.4684042733927;885.7564169853213;9451.952740236255;9774.609015639437;9797.118259356692;9835.262355323379;9840.16358609512;363006;367579;371143;372340.5531889347;380772;47379.05241895212;54113.72943135338;75272;77812.61093694496;78234.47944842496;857.6783706110209;867.9218870301703;875.282268539804;895.4403497813867;934.4486752815735;15693.529194124194;16005.839941600434;16069.678606427573;16125.67748645044;16304.51086467408;30869.228269293446;33067.338653227285;38448.80775596104;38855.222895542494;39686.404703928885;51839.74080129575;52333;53336.1999569999;53986.46013539971;54538;7682.347000504796;7724.459287850022;7945.364370850433;7983.760487185394;7990.360771138178;10460.79078418412;11772.352520611106;11912.225705329125;12232.204906681038;12255.080868935043;9807.803843923224;9814.852777208205;9944;10093.5457904393;10208.540615672164;9722.854157187507;9935.751606209902;10154.949225253826;10385.948070259601;10709.08972737326;10006.249531285037;10112.191024718151;10441.895581044093;10498.47507624631;10621.681349559525;7605.88591171144;7885.093214280431;7948.125706172432;8003.079645840803;8047.1550487198;9759.121679048636;10089.89910100919;10556.208284378856;10826.350418974887;11009.61466348674 01:18:18 INFO - PROCESS | 3528 | |3;mootools.html;1187.7446349034956;1272.4719241514772;1337.8260826092605;1350.2101270756607;1648.2006226979913;7338.266173382665;7650;7700.229977002304;7941.483803552765;7972.322352600036;7589.392848572114;7730.768076957686;7737.22627737226;7744.92255077449;7780.533168009923;1896.6111947050822;1956.2664000999625;1958.7551556055494;2186.2348178137645;2229.576380487702;1950.570874407628;2154.5798569278995;2234.9888250558724;2237.272886311947;2238.7425446073667;2188.3763127508664;2208.216083290433;2221.822254219667;2227.2538699535676;2228.2869481765842;1855.8236967488067;2153.6661817418326;2160.0495781855934;2163.9675404868863;2165.0798410675557;2120.7455105387453;2183.443221978401;2185.8360622953182;2186.6173419651655;2188.616992026389;7887.645055972495;7935.206479352077;7950.403719720986;7950.840983180362;7951.125376208613;4502.729836209838;4649.1399091167905;4651.44182698075;4654.720716756971;4654.767261636938;2804.957925631117;2875.151830210093;2885.9134225973253;2903.274181454636;2936.721011503904;877.5875338590852;894.0612357025162;898.6540182029966;921.0927236671873;923.1507013547553;10727.141828653688;10752.032317091422;10757.83863242052;10770.515326810233;10777.622783202629;4037.313656678372;4129.112240868228;4221.092465119953;4221.2190744712325;4222.345536441856;9211.217046550984;9241.815163696689;9242.012967212082;9254.907450925539;9255.120763527455;4647.883802904955;4656.208444564364;4689.437267527918;4714.5992590630185;4715.127701375257;3615.8192090395373;3621.8008009559726;4178.895527611773;4235.682323825726;4236.068065025689;3558.3061303046175;3713.8700145494777;3730.1047748540154;3772.7359084863797;3784.0729021389934;1176.1355403778216;1194.976100478003;1199.5681554640323;1212.5513559982687;1215.8115492098561;775.6897241103603;832.1137988042836;859.8968123825181;871.5729292646685;889.2619126125301;5193.870153246199;5283.9471605284225;5417.3770016447825;5529.778808847682;5589.301337332833;406.51827584312684;413.4542404026656;416.2008942829774;419.3458205199898;437.0712236497443;3566.3045706087582;3666.9816650916573;3670.596234414212;3706.314331848617;3747.5315585551807;9246.815063698688;9449.90550094504;9462.810743785223;9567.760805979768;9592.9040709592;9475.05249475047;9496.620135194515;9516.000819913948;9527.523623818919;9555.713328600154;7151.7854464366155;7195.208527062124;7231.63841807918;7245.166805817293;7265.782026539212;5451.836444906659;5513.145462453326;5532.699815543425;5616.747246373841;5633.971830140987;8802.91197088021;8900.06549312313;9037.68368107113;9046.638134474548;9060.365774395728;8701;9040;9212.769680758034;9222.907770922206;9223.308251881002;6139.662318572343;6332.493400527855;6335.968320158369;6835.248122706597;6923.965380173268;6897.620630865351;7131.144262688511;7311.195768465358;7354.080739907512;7497.662605182671;6647.335266473314;6666.699998500176;6769.356911093439;6829.146356705412;6884.965575172092;6494.253160886369;6526.738930442919;6577.967110164419;6614.239362473377;6685.799426017227;5978.4021597839865;6017.458428741435;6040.1543783871175;6047.123167140828;6052.667103309184;4588.747618880993;4633.814647414066;4688.226442636927;4755.048990201904;4846.733429661403;4784.569388755029;4812.903741925212;4899.583535399531;4918.852434426973;4946.802127914843 01:18:18 INFO - PROCESS | 3528 | |4;prototype.html;301.5913437292469;303.87541108145666;304.6466099324782;305.9556364327172;312.640463467013;4881.0969970555425;4898.093852637265;4922.483139270379;4926.876828079296;4940.925886111711;4840.596227094147;4852.369192005043;4860.878478038051;4886.998165376098;4897.902041959159;3681.153334733013;3792.4500947362617;3807.8476860925666;3808.447775072613;3829.4447305140875;3652.689521390685;3810.7523011004337;3815.0271680721376;3851.4993050903345;3855.9807200963955;3692.833822477995;3729.1982223821874;3779.622037796212;3798.810059497028;3813.8474461021524;3585.748997570171;3761.661450469457;3787.6780473659774;3797.39241721326;3830.8276127574327;3314.486254630536;3320.9501857472155;3333.5499707539416;3340.914202884048;3344.180675734436;4727.929081063787;4737.952620473786;4755.619550435957;4764.2615394613895;4768.737719425465;4310.418093557392;4316.762578058206;4331.696781225315;4333.1766964276685;4339.47926248849;4920.434150072751;5046.839226977779;5056.292119103328;5075.340205773263;5101.591872650179;3597.334493118781;3607.6392360763975;3609.350316942949;3615.783053016801;3637.909052273714;5276.551493123051;5316.623943795717;5321.813736519242;5345;5371.597130215249;3601.3877640801124;3674.0080178351695;3677.8712745053795;3692;3702.7593206441493;3731.9626803731617;3732.234891847165;3753.5683396409217;3757.3236817373136;3767.1900541383184;4202.915941681211;4208.075387605585;4242.300020496584;4246.40550322955;4253.63844073251;4831.903361932742;5067.822626208065;5067.822626208065;5070.340855688737;5113.28995632308;1297.3642914971786;1311.4491913396396;1311.9344032798322;1313.487739781486;1317.5586178630074;806.3790881021698;825.7316372179066;827.611022819274;835.1398059998212;843.5234092737584;4312.741235525878;4508.752018638941;4517.412736344254;4559.4072770539615;4562.6996306052615;5233.712145832016;5278.868028299246;5283.4452382499285;5284.678830292427;5286.894262114736;4506.887327816831;4515.932261016087;4521.457425109008;4522.773861306921;4534.891275556882;2618.0574993002883;2778.9861050694617;2817.9859100704775;2832.6459192600923;2832.702566230516;4933.975330123327;4969.801207951714;4976.2038073908;4996.175631020841;5014;5184;5300.257963885059;5317.404778566414;5335.866603334947;5346.599005074635;4899.3385892904;4900.534449227318;4901.632377571767;4922.852314430501;4950.43070046942;5236.554892834151;5239.109351410193;5249.133892907627;5250.18622113573;5257.526822585985;4953.365389421554;5024.568077349951;5079.822206222764;5141.614378921521;5144.30551875507;4898.657094003385;4901.995091006406;4930.742660621519;4946.15915294408;4970.179920313252;3386.7629265951145;3408.2672225471642;3492.9825350873084;3498.8600455981477;3499.3001399720665;4642.628589712883;4720.480747117883;4796.66423350376;4818.879528011687;4958.404991401055;5134.666246693953;5159.484051594811;5168.276441298296;5168.3539557555305;5170.508801663836;5115.9232611510115;5117.974410127926;5124.871878203075;5159.226116082467;5172.043172013189;4865.878353041061;5073.365829271341;5081.92377114351;5095.363079615048;5101.591872650253;4943.555080042814;5037.596992240538;5079.3650793650795;5092.439831618445;5199.168133098686;5016.498350164954;5022.020705962303;5024.42219144803;5040.521150490697;5049.621278404208 01:18:18 INFO - PROCESS | 3528 | |5;yui.html;647.7861510871778;669.4376723552215;701.8736627407067;712.693541777036;726.960017199054;12609.684757881058;13255.40350684219;13633;13989.370478328474;13995.020348575617;13548.72902541951;13549.254790986492;13743.725125497484;13746.93126534366;13762.174269543835;627.6673363117555;637.2257706886132;639.1275908385068;766.5477368352671;791.5092642561619;639.1722719078804;773.5861314196906;774.248978490863;778.8091917480197;783.8706613408809;817.5503473089807;819.0212695828487;821.0926925747024;822.6914906909909;823.6993497373445;646.9094326794252;820.5979070255592;821.4250024982476;821.5153059694809;822.9341652667803;589.0722112672557;594.7323704333024;600.504583718434;601.8344955137328;604.927408710953;11684.591039313667;11716.355600441972;11722.58970936013;11741.589044383405;11744.765104697944;12352.814707779391;12838.55065072718;12891.87108128916;13171.407286672124;13322.134061286082;11616.88383116175;11631.6510504685;11859.40702964857;12023.27860328383;12217.93891030539;4099.405586189986;4152.626263636287;4168.145530166339;4280.743155410685;4284.186004659136;63052.36947630511;63131.68434157846;63413.68293158551;64190.999999999534;64303;9429.48137852411;9586.66446674377;9648.517574121266;9950.950245248727;9989.350692204984;17870.731939020927;17943.820561794215;17951.640967180585;17954.012529310752;17977.280908763765;6301.6219026858535;6346.904796428057;6427.614343139427;6469.417752402306;6570.507211959122;3772.9434058489146;3780.0360907968293;3826.1199924017633;3855.306044911943;3872.651461368434;2629.618705287761;2722.4555088982283;2729.3449572102554;2731.1260396672874;2733.494303553809;506.65294273422825;522.3288074823909;525.7056048612789;527.380328114464;539.3366159623606;529.8278059630635;552.2847911954029;556.2796178948272;561.0406205388831;584.8303991842319;7414.555126692416;7416.7404140854815;7613.155356544909;7619.885701714478;7781.766547003599;436.99273175330535;444.7220487195503;485.19215506181814;516.5841497594397;551.6938099354817;3420.863165473403;3593.1017245688577;3613.765105268149;3647.76289541179;3744.475773391727;77587.61206193933;77940;80670;80791;95732;49119;49487;49973.75013124911;50000.24999625009;50873.491265087614;72656;74711.62644186744;74981.25018749743;77489.612551938;78703;8759.12408759119;8798.604062817061;8805.735827925173;8872.822543549222;8895.599698013735;42294.57705423029;43139.784301078296;44079.33880991724;44609.330860036476;44621.33068003917;58428;61853;62165.68917155566;62213.68893155505;62243.37756622376;11975.520979160736;12156.392180391122;12177.452014659539;12468.875311246771;12926.547570834975;11785.410729463663;11862.82205766897;12286.692832678897;13476.93261533686;13699.315034248448;9167.23303881991;12274.525964579381;12910.741785164057;12916.935415322863;13590.388432520362;12178.208416452902;12263.141580089308;12357.32034738062;12387.256764594153;12524.812127817908;11553.422328883691;11668.416579171177;11961.700957476132;11999;12112.454939527566;9328.860067099135;10649.733756656145;10655.30740501865;10689.893101069201;10920.945395272973;10248.669261937002;10765.30025548337;10807.13542916549;10817.459127043774;10970.725731856768 01:18:18 INFO - PROCESS | 3528 | __end_tp_report 01:18:18 INFO - PROCESS | 3528 | __start_cc_report 01:18:18 INFO - PROCESS | 3528 | _x_x_mozilla_cycle_collect,1063 01:18:18 INFO - PROCESS | 3528 | __end_cc_report 01:18:18 INFO - PROCESS | 3528 | __startTimestamp1466583498264__endTimestamp 01:18:18 INFO - PROCESS | 3528 | 01:18:18 INFO - PROCESS | 3528 | ------- Summary: start ------- 01:18:18 INFO - PROCESS | 3528 | Number of tests: 6 01:18:18 INFO - PROCESS | 3528 | 01:18:18 INFO - PROCESS | 3528 | [#0] dojo.html Cycles:165 Average:4797.85 Median:4944.41 stddev:507.56 (10.3%) stddev-sans-first:480.95 01:18:18 INFO - PROCESS | 3528 | Values: 2672.4 2679.9 2706.9 2712.5 2715.9 4703.9 4765.8 4776.7 4912.6 4944.4 4810.6 4825.7 4834.0 4851.3 4885.9 4422.9 4449.2 4468.5 4490.3 4545.0 4431.0 4494.2 4503.9 4532.5 4546.1 4311.3 4414.5 4481.7 4496.2 4506.1 4316.5 4389.1 4390.5 4424.5 4432.2 4372.7 4433.0 4454.9 4469.1 4497.8 4689.5 4859.7 4874.2 4920.6 4937.7 5138.6 5193.1 5195.3 5275.8 5279.9 5258.2 5264.3 5293.6 5295.0 5309.9 4714.7 4826.0 4948.4 4951.4 4952.2 5295.4 5338.9 5356.2 5406.2 5422.5 5175.5 5200.1 5207.6 5209.8 5212.2 4981.6 5099.0 5147.5 5205.5 5263.8 5114.1 5131.2 5135.4 5138.0 5167.2 5095.3 5097.1 5103.2 5122.2 5152.3 4279.3 4314.9 4315.8 4368.1 4389.0 3856.9 3874.6 3911.7 3959.4 3963.5 4467.4 4467.5 4471.7 4473.0 4520.8 4998.6 5169.4 5250.5 5259.2 5310.8 4426.8 4454.1 4472.4 4514.6 4520.4 4690.6 4700.1 4701.1 4705.8 4751.0 4682.0 4827.3 4853.8 4885.3 4891.6 5226.2 5239.5 5244.9 5249.1 5294.5 4887.4 4894.4 4896.9 4898.7 4949.5 4938.2 5066.1 5073.2 5104.9 5168.0 5190.1 5190.7 5193.7 5198.0 5213.8 5049.2 5052.2 5052.4 5053.4 5055.9 4866.0 5015.9 5041.3 5072.5 5082.6 4956.6 5019.9 5061.8 5065.2 5068.6 4953.3 5042.9 5053.3 5063.8 5085.0 4965.2 5006.5 5017.2 5041.2 5059.1 01:18:18 INFO - PROCESS | 3528 | 01:18:18 INFO - PROCESS | 3528 | [#1] ext.html Cycles:180 Average:44549.50 Median:36531.54 stddev:84702.37 (231.9%) stddev-sans-first:84875.55 01:18:18 INFO - PROCESS | 3528 | Values: 546.5 580.9 586.9 593.6 603.1 26651.3 39430.8 40522.2 40559.8 44143.6 39849.8 40211.8 40400.4 40425.8 40450.2 7902.0 7918.2 7971.3 7989.5 7994.8 7795.8 7869.7 7894.3 7896.4 7899.8 7938.2 7976.9 8019.4 8021.5 8022.2 7952.7 7968.4 7997.8 7997.9 8003.6 7934.2 7981.3 8003.4 8006.6 8008.1 38491.8 38598.6 38635.2 38645.6 38683.4 3113.8 3308.3 3332.7 3441.8 3501.1 29328.3 29772.7 30183.3 30666.2 31071.8 3280.9 3313.6 3348.0 3355.3 3413.1 181370.0 181388.0 181600.0 181646.0 183105.0 27675.6 28247.7 28305.4 51120.0 51937.5 33893.3 34113.8 34114.5 34123.5 34155.3 13176.3 13257.1 13257.3 13260.4 13270.2 10891.1 10919.2 10919.7 10920.8 10928.1 7930.2 7941.3 7942.9 8000.3 8008.1 3108.7 3148.0 3173.6 3173.7 3206.3 814.0 843.9 888.8 954.7 1013.8 26369.5 27472.0 27618.2 27686.3 27722.4 780.5 927.5 945.0 962.4 974.6 14324.3 14572.3 14811.0 14911.3 15028.5 374749.0 378081.0 380702.0 381273.0 382256.0 48115.5 48560.5 48615.3 48705.0 48751.8 1087.8 1161.6 1197.5 1214.7 1214.8 28019.2 29402.0 29821.0 29874.6 30009.4 36547.3 36576.0 36902.4 36970.4 37009.8 295836.0 296527.0 297156.0 298401.0 538467.0 24798.9 25479.5 25508.5 26715.5 26725.6 42228.0 42920.6 43208.1 44337.1 48501.3 36230.0 37264.4 37597.2 37687.0 37719.2 36417.3 36515.8 36600.6 36745.1 37090.8 35677.5 35835.6 36210.8 36497.5 36699.4 29508.1 29911.6 29999.1 30360.7 30392.5 25283.8 25810.7 25905.6 26112.7 26352.7 01:18:18 INFO - PROCESS | 3528 | 01:18:18 INFO - PROCESS | 3528 | [#2] jquery.html Cycles:180 Average:23334.16 Median:4696.50 stddev:61230.96 (1303.8%) stddev-sans-first:61378.47 01:18:18 INFO - PROCESS | 3528 | Values: 377.2 378.5 384.7 390.8 394.1 15614.9 16915.0 17376.9 17569.8 17629.4 15591.9 16742.3 17161.7 17238.3 17252.6 4511.0 4659.3 4733.7 4735.2 4735.2 3481.4 5118.7 5417.6 5419.1 5487.4 5378.0 5450.2 5465.9 5483.8 5487.5 5294.3 5401.8 5404.6 5409.6 5475.6 3368.6 4981.4 5355.7 5359.2 5412.7 11930.9 12091.5 12094.8 17309.8 20459.2 1932.6 1988.5 1999.3 2011.8 2023.5 8721.9 9063.6 9085.6 9258.1 9646.7 1719.6 1728.9 1740.0 1774.1 1814.8 65868.7 67871.0 68540.0 68763.7 70304.6 9837.8 9927.6 10205.3 10252.6 10974.6 13809.5 13884.4 13968.5 13970.7 14017.5 6790.7 7057.6 7173.7 7230.7 7235.2 6582.2 6601.4 6754.0 6773.5 6773.6 4354.6 4441.8 4455.6 4527.3 4583.9 1698.4 1763.7 1830.3 1834.4 1835.5 736.4 757.4 860.6 894.7 910.1 15923.4 16588.8 16636.7 16700.6 16803.1 833.8 858.7 862.2 871.5 885.8 9452.0 9774.6 9797.1 9835.3 9840.2 363006.0 367579.0 371143.0 372340.6 380772.0 47379.1 54113.7 75272.0 77812.6 78234.5 857.7 867.9 875.3 895.4 934.4 15693.5 16005.8 16069.7 16125.7 16304.5 30869.2 33067.3 38448.8 38855.2 39686.4 51839.7 52333.0 53336.2 53986.5 54538.0 7682.3 7724.5 7945.4 7983.8 7990.4 10460.8 11772.4 11912.2 12232.2 12255.1 9807.8 9814.9 9944.0 10093.5 10208.5 9722.9 9935.8 10154.9 10385.9 10709.1 10006.2 10112.2 10441.9 10498.5 10621.7 7605.9 7885.1 7948.1 8003.1 8047.2 9759.1 10089.9 10556.2 10826.4 11009.6 01:18:18 INFO - PROCESS | 3528 | 01:18:18 INFO - PROCESS | 3528 | [#3] mootools.html Cycles:180 Average:5122.22 Median:5238.91 stddev:2895.73 (55.3%) stddev-sans-first:2888.76 01:18:18 INFO - PROCESS | 3528 | Values: 1187.7 1272.5 1337.8 1350.2 1648.2 7338.3 7650.0 7700.2 7941.5 7972.3 7589.4 7730.8 7737.2 7744.9 7780.5 1896.6 1956.3 1958.8 2186.2 2229.6 1950.6 2154.6 2235.0 2237.3 2238.7 2188.4 2208.2 2221.8 2227.3 2228.3 1855.8 2153.7 2160.0 2164.0 2165.1 2120.7 2183.4 2185.8 2186.6 2188.6 7887.6 7935.2 7950.4 7950.8 7951.1 4502.7 4649.1 4651.4 4654.7 4654.8 2805.0 2875.2 2885.9 2903.3 2936.7 877.6 894.1 898.7 921.1 923.2 10727.1 10752.0 10757.8 10770.5 10777.6 4037.3 4129.1 4221.1 4221.2 4222.3 9211.2 9241.8 9242.0 9254.9 9255.1 4647.9 4656.2 4689.4 4714.6 4715.1 3615.8 3621.8 4178.9 4235.7 4236.1 3558.3 3713.9 3730.1 3772.7 3784.1 1176.1 1195.0 1199.6 1212.6 1215.8 775.7 832.1 859.9 871.6 889.3 5193.9 5283.9 5417.4 5529.8 5589.3 406.5 413.5 416.2 419.3 437.1 3566.3 3667.0 3670.6 3706.3 3747.5 9246.8 9449.9 9462.8 9567.8 9592.9 9475.1 9496.6 9516.0 9527.5 9555.7 7151.8 7195.2 7231.6 7245.2 7265.8 5451.8 5513.1 5532.7 5616.7 5634.0 8802.9 8900.1 9037.7 9046.6 9060.4 8701.0 9040.0 9212.8 9222.9 9223.3 6139.7 6332.5 6336.0 6835.2 6924.0 6897.6 7131.1 7311.2 7354.1 7497.7 6647.3 6666.7 6769.4 6829.1 6885.0 6494.3 6526.7 6578.0 6614.2 6685.8 5978.4 6017.5 6040.2 6047.1 6052.7 4588.7 4633.8 4688.2 4755.0 4846.7 4784.6 4812.9 4899.6 4918.9 4946.8 01:18:18 INFO - PROCESS | 3528 | 01:18:18 INFO - PROCESS | 3528 | [#4] prototype.html Cycles:180 Average:4210.37 Median:4846.48 stddev:1229.92 (25.4%) stddev-sans-first:1197.86 01:18:18 INFO - PROCESS | 3528 | Values: 301.6 303.9 304.6 306.0 312.6 4881.1 4898.1 4922.5 4926.9 4940.9 4840.6 4852.4 4860.9 4887.0 4897.9 3681.2 3792.5 3807.8 3808.4 3829.4 3652.7 3810.8 3815.0 3851.5 3856.0 3692.8 3729.2 3779.6 3798.8 3813.8 3585.7 3761.7 3787.7 3797.4 3830.8 3314.5 3321.0 3333.5 3340.9 3344.2 4727.9 4738.0 4755.6 4764.3 4768.7 4310.4 4316.8 4331.7 4333.2 4339.5 4920.4 5046.8 5056.3 5075.3 5101.6 3597.3 3607.6 3609.4 3615.8 3637.9 5276.6 5316.6 5321.8 5345.0 5371.6 3601.4 3674.0 3677.9 3692.0 3702.8 3732.0 3732.2 3753.6 3757.3 3767.2 4202.9 4208.1 4242.3 4246.4 4253.6 4831.9 5067.8 5067.8 5070.3 5113.3 1297.4 1311.4 1311.9 1313.5 1317.6 806.4 825.7 827.6 835.1 843.5 4312.7 4508.8 4517.4 4559.4 4562.7 5233.7 5278.9 5283.4 5284.7 5286.9 4506.9 4515.9 4521.5 4522.8 4534.9 2618.1 2779.0 2818.0 2832.6 2832.7 4934.0 4969.8 4976.2 4996.2 5014.0 5184.0 5300.3 5317.4 5335.9 5346.6 4899.3 4900.5 4901.6 4922.9 4950.4 5236.6 5239.1 5249.1 5250.2 5257.5 4953.4 5024.6 5079.8 5141.6 5144.3 4898.7 4902.0 4930.7 4946.2 4970.2 3386.8 3408.3 3493.0 3498.9 3499.3 4642.6 4720.5 4796.7 4818.9 4958.4 5134.7 5159.5 5168.3 5168.4 5170.5 5115.9 5118.0 5124.9 5159.2 5172.0 4865.9 5073.4 5081.9 5095.4 5101.6 4943.6 5037.6 5079.4 5092.4 5199.2 5016.5 5022.0 5024.4 5040.5 5049.6 01:18:18 INFO - PROCESS | 3528 | 01:18:18 INFO - PROCESS | 3528 | [#5] yui.html Cycles:180 Average:16494.19 Median:24802.10 stddev:22088.66 (89.1%) stddev-sans-first:22118.58 01:18:18 INFO - PROCESS | 3528 | Values: 647.8 669.4 701.9 712.7 727.0 12609.7 13255.4 13633.0 13989.4 13995.0 13548.7 13549.3 13743.7 13746.9 13762.2 627.7 637.2 639.1 766.5 791.5 639.2 773.6 774.2 778.8 783.9 817.6 819.0 821.1 822.7 823.7 646.9 820.6 821.4 821.5 822.9 589.1 594.7 600.5 601.8 604.9 11684.6 11716.4 11722.6 11741.6 11744.8 12352.8 12838.6 12891.9 13171.4 13322.1 11616.9 11631.7 11859.4 12023.3 12217.9 4099.4 4152.6 4168.1 4280.7 4284.2 63052.4 63131.7 63413.7 64191.0 64303.0 9429.5 9586.7 9648.5 9951.0 9989.4 17870.7 17943.8 17951.6 17954.0 17977.3 6301.6 6346.9 6427.6 6469.4 6570.5 3772.9 3780.0 3826.1 3855.3 3872.7 2629.6 2722.5 2729.3 2731.1 2733.5 506.7 522.3 525.7 527.4 539.3 529.8 552.3 556.3 561.0 584.8 7414.6 7416.7 7613.2 7619.9 7781.8 437.0 444.7 485.2 516.6 551.7 3420.9 3593.1 3613.8 3647.8 3744.5 77587.6 77940.0 80670.0 80791.0 95732.0 49119.0 49487.0 49973.8 50000.2 50873.5 72656.0 74711.6 74981.3 77489.6 78703.0 8759.1 8798.6 8805.7 8872.8 8895.6 42294.6 43139.8 44079.3 44609.3 44621.3 58428.0 61853.0 62165.7 62213.7 62243.4 11975.5 12156.4 12177.5 12468.9 12926.5 11785.4 11862.8 12286.7 13476.9 13699.3 9167.2 12274.5 12910.7 12916.9 13590.4 12178.2 12263.1 12357.3 12387.3 12524.8 11553.4 11668.4 11961.7 11999.0 12112.5 9328.9 10649.7 10655.3 10689.9 10920.9 10248.7 10765.3 10807.1 10817.5 10970.7 01:18:18 INFO - PROCESS | 3528 | -------- Summary: end -------- 01:18:18 INFO - PROCESS | 3528 | 01:18:18 INFO - TEST-INFO | 3528: exit 0 01:18:19 INFO - TEST-OK | dromaeo_css | took 1122390ms 01:18:19 INFO - TEST-START | kraken 01:18:19 INFO - operating with platform_type : linux_ 01:18:19 INFO - Initialising browser for kraken test... 01:18:19 INFO - TEST-INFO | started process 3715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXG22MA/profile http://localhost:52523/getInfo.html) 01:18:23 INFO - PROCESS | 3715 | __metrics Screen width/height:1600/1200 01:18:23 INFO - PROCESS | 3715 | colorDepth:24 01:18:23 INFO - PROCESS | 3715 | Browser inner width/height: 1024/697 01:18:23 INFO - PROCESS | 3715 | __metrics 01:18:24 INFO - PROCESS | 3715 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:18:25 INFO - TEST-INFO | 3715: exit 0 01:18:25 INFO - Browser initialized. 01:18:25 INFO - Running cycle 1/1 for kraken test... 01:18:25 INFO - TEST-INFO | started process 3794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXG22MA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:18:37 INFO - PROCESS | 3794 | RSS: Main: 175161344 01:18:37 INFO - PROCESS | 3794 | 01:18:40 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52523/tests/kraken/driver.html?testName=audio-beat-detection) 01:18:41 INFO - PROCESS | 3794 | RSS: Main: 233451520 01:18:41 INFO - PROCESS | 3794 | 01:18:44 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52523/tests/kraken/driver.html?testName=audio-dft) 01:18:45 INFO - PROCESS | 3794 | RSS: Main: 221044736 01:18:45 INFO - PROCESS | 3794 | 01:18:48 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52523/tests/kraken/driver.html?testName=audio-fft) 01:18:48 INFO - PROCESS | 3794 | RSS: Main: 289464320 01:18:48 INFO - PROCESS | 3794 | 01:18:51 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52523/tests/kraken/driver.html?testName=audio-oscillator) 01:18:51 INFO - PROCESS | 3794 | RSS: Main: 199200768 01:18:51 INFO - PROCESS | 3794 | 01:18:53 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52523/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:18:54 INFO - PROCESS | 3794 | RSS: Main: 203284480 01:18:54 INFO - PROCESS | 3794 | 01:18:57 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52523/tests/kraken/driver.html?testName=imaging-darkroom) 01:18:58 INFO - PROCESS | 3794 | RSS: Main: 239325184 01:18:58 INFO - PROCESS | 3794 | 01:19:01 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52523/tests/kraken/driver.html?testName=imaging-desaturate) 01:19:02 INFO - PROCESS | 3794 | RSS: Main: 235085824 01:19:02 INFO - PROCESS | 3794 | 01:19:05 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52523/tests/kraken/driver.html?testName=json-parse-financial) 01:19:05 INFO - PROCESS | 3794 | RSS: Main: 237543424 01:19:05 INFO - PROCESS | 3794 | 01:19:07 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52523/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:19:08 INFO - PROCESS | 3794 | RSS: Main: 225677312 01:19:08 INFO - PROCESS | 3794 | 01:19:10 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52523/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:19:10 INFO - PROCESS | 3794 | RSS: Main: 231137280 01:19:10 INFO - PROCESS | 3794 | 01:19:12 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52523/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:19:13 INFO - PROCESS | 3794 | RSS: Main: 239083520 01:19:13 INFO - PROCESS | 3794 | 01:19:16 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:19:17 INFO - PROCESS | 3794 | RSS: Main: 239558656 01:19:17 INFO - PROCESS | 3794 | 01:19:19 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:19:20 INFO - PROCESS | 3794 | RSS: Main: 239349760 01:19:20 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:52523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52523/tests/kraken/driver.html?testName=ai-astar) 01:19:22 INFO - PROCESS | 3794 | RSS: Main: 281972736 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | __start_tp_report 01:19:22 INFO - PROCESS | 3794 | _x_x_mozilla_page_load 01:19:22 INFO - PROCESS | 3794 | _x_x_mozilla_page_load_details 01:19:22 INFO - PROCESS | 3794 | |i|pagename|runs| 01:19:22 INFO - PROCESS | 3794 | |0;ai-astar;115;108;113;113;112;113;114;113;113;113 01:19:22 INFO - PROCESS | 3794 | |1;audio-beat-detection;153;131;134;180;130;131;156;129;178;133 01:19:22 INFO - PROCESS | 3794 | |2;audio-dft;165;163;162;162;162;161;164;163;164;161 01:19:22 INFO - PROCESS | 3794 | |3;audio-fft;74;77;77;108;77;78;74;75;98;76 01:19:22 INFO - PROCESS | 3794 | |4;audio-oscillator;87;85;117;85;86;86;113;85;87;124 01:19:22 INFO - PROCESS | 3794 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;118;117;117 01:19:22 INFO - PROCESS | 3794 | |6;imaging-darkroom;146;146;146;146;147;146;145;145;146;145 01:19:22 INFO - PROCESS | 3794 | |7;imaging-desaturate;95;96;96;95;95;95;95;95;94;95 01:19:22 INFO - PROCESS | 3794 | |8;json-parse-financial;65;61;63;63;63;63;67;63;64;63 01:19:22 INFO - PROCESS | 3794 | |9;json-stringify-tinderbox;65;75;64;65;64;65;65;66;65;66 01:19:22 INFO - PROCESS | 3794 | |10;stanford-crypto-aes;82;83;83;83;87;84;84;85;111;83 01:19:22 INFO - PROCESS | 3794 | |11;stanford-crypto-ccm;139;141;128;129;132;140;129;134;138;138 01:19:22 INFO - PROCESS | 3794 | |12;stanford-crypto-pbkdf2;169;178;169;169;169;170;166;169;168;175 01:19:22 INFO - PROCESS | 3794 | |13;stanford-crypto-sha256-iterative;68;72;69;67;70;71;69;66;66;67 01:19:22 INFO - PROCESS | 3794 | __end_tp_report 01:19:22 INFO - PROCESS | 3794 | __start_cc_report 01:19:22 INFO - PROCESS | 3794 | _x_x_mozilla_cycle_collect,1884 01:19:22 INFO - PROCESS | 3794 | __end_cc_report 01:19:22 INFO - PROCESS | 3794 | __startTimestamp1466583562528__endTimestamp 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | ------- Summary: start ------- 01:19:22 INFO - PROCESS | 3794 | Number of tests: 14 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.83 (1.6%) stddev-sans-first:1.74 01:19:22 INFO - PROCESS | 3794 | Values: 115.0 108.0 113.0 113.0 112.0 113.0 114.0 113.0 113.0 113.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:143.50 stddev:20.10 (14.0%) stddev-sans-first:21.13 01:19:22 INFO - PROCESS | 3794 | Values: 153.0 131.0 134.0 180.0 130.0 131.0 156.0 129.0 178.0 133.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.13 01:19:22 INFO - PROCESS | 3794 | Values: 165.0 163.0 162.0 162.0 162.0 161.0 164.0 163.0 164.0 161.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#3] audio-fft Cycles:10 Average:81.40 Median:77.00 stddev:11.70 (15.2%) stddev-sans-first:12.10 01:19:22 INFO - PROCESS | 3794 | Values: 74.0 77.0 77.0 108.0 77.0 78.0 74.0 75.0 98.0 76.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:85.50 stddev:15.76 (18.4%) stddev-sans-first:16.42 01:19:22 INFO - PROCESS | 3794 | Values: 87.0 85.0 117.0 85.0 86.0 86.0 113.0 85.0 87.0 124.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:19:22 INFO - PROCESS | 3794 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 01:19:22 INFO - PROCESS | 3794 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 145.0 145.0 146.0 145.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 01:19:22 INFO - PROCESS | 3794 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.58 01:19:22 INFO - PROCESS | 3794 | Values: 65.0 61.0 63.0 63.0 63.0 63.0 67.0 63.0 64.0 63.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.00 stddev:3.23 (5.0%) stddev-sans-first:3.41 01:19:22 INFO - PROCESS | 3794 | Values: 65.0 75.0 64.0 65.0 64.0 65.0 65.0 66.0 65.0 66.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:83.50 stddev:8.72 (10.4%) stddev-sans-first:9.10 01:19:22 INFO - PROCESS | 3794 | Values: 82.0 83.0 83.0 83.0 87.0 84.0 84.0 85.0 111.0 83.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:138.00 stddev:5.01 (3.6%) stddev-sans-first:5.07 01:19:22 INFO - PROCESS | 3794 | Values: 139.0 141.0 128.0 129.0 132.0 140.0 129.0 134.0 138.0 138.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:169.00 stddev:3.55 (2.1%) stddev-sans-first:3.74 01:19:22 INFO - PROCESS | 3794 | Values: 169.0 178.0 169.0 169.0 169.0 170.0 166.0 169.0 168.0 175.0 01:19:22 INFO - PROCESS | 3794 | 01:19:22 INFO - PROCESS | 3794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:2.07 (3.0%) stddev-sans-first:2.19 01:19:22 INFO - PROCESS | 3794 | Values: 68.0 72.0 69.0 67.0 70.0 71.0 69.0 66.0 66.0 67.0 01:19:22 INFO - PROCESS | 3794 | -------- Summary: end -------- 01:19:22 INFO - PROCESS | 3794 | 01:19:23 INFO - TEST-INFO | 3794: exit 0 01:19:23 INFO - TEST-OK | kraken | took 64603ms 01:19:23 INFO - SUITE-END | took 1186s 01:19:23 INFO - Completed test suite (00:19:47) 01:19:23 INFO - javascript benchmark 01:19:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.4254285328657, 2679.933001674959, 2706.9187924362263, 2712.471068141713, 2715.891364345426, 4703.882402939919, 4765.809367625291, 4776.713397196167, 4912.582430493403, 4944.4066711994565, 4810.615150787938, 4825.71045737256, 4833.951660483394, 4851.296561998517, 4885.853424397274, 4422.889427764299, 4449.154660614473, 4468.50846406895, 4490.3040028795585, 4544.977380089486, 4430.9778451107695, 4494.16857881293, 4503.932441013371, 4532.501424843264, 4546.090781843628, 4311.28863737483, 4414.514403415622, 4481.731096134243, 4496.213162696547, 4506.121306345264, 4316.48202215733, 4389.078293558325, 4390.538993405678, 4424.469063712343, 4432.22436073689, 4372.672049596293, 4433.0, 4454.933176002362, 4469.10617876426, 4497.820087196508, 4689.50760170184, 4859.684120532154, 4874.195757699975, 4920.581750551208, 4937.703737775709, 5138.58891288696, 5193.065248255312, 5195.272661827347, 5275.815346462894, 5279.947200527984, 5258.237555554461, 5264.315638966948, 5293.57651387888, 5295.0468915595175, 5309.867253318698, 4714.740689262055, 4826.0, 4948.356713627206, 4951.405831300267, 4952.182889823211, 5295.364556253197, 5338.91991620126, 5356.1697936819855, 5406.216098665672, 5422.511973922287, 5175.482451754794, 5200.115980283361, 5207.635465517453, 5209.765560549784, 5212.192110222922, 4981.551660350586, 5099.0, 5147.459516750762, 5205.45342739007, 5263.842084737464, 5114.105031619451, 5131.153359695683, 5135.4094279157625, 5137.974310128426, 5167.22491626259, 5095.337606111182, 5097.082525145435, 5103.157978933508, 5122.154844450624, 5152.252923326097, 4279.336702811007, 4314.935275970863, 4315.8489452869, 4368.126374725068, 4388.978055109704, 3856.9035774105873, 3874.5931677174053, 3911.6675082618294, 3959.3862951242604, 3963.5441924178513, 4467.441569803775, 4467.463904331501, 4471.709338893027, 4473.0, 4520.841770538082, 4998.600111991032, 5169.353830771153, 5250.501202385767, 5259.158534634516, 5310.8141215057285, 4426.756528390905, 4454.064646424287, 4472.39622650938, 4514.616257618073, 4520.434945631796, 4690.554397332248, 4700.130475861976, 4701.083288758659, 4705.811767529261, 4750.976245118753, 4682.0401817626625, 4827.275908613736, 4853.80584776605, 4885.340479035356, 4891.633127515522, 5226.242194881797, 5239.528442440199, 5244.947550524446, 5249.13389290778, 5294.497022782984, 4887.437944636412, 4894.437139728977, 4896.877578060435, 4898.681585696918, 4949.480304567968, 4938.185199442052, 5066.138756411346, 5073.213651883964, 5104.948950510596, 5167.974160129175, 5190.117679994485, 5190.740462976761, 5193.714345711022, 5198.0, 5213.76538055796, 5049.166887463674, 5052.1663925451885, 5052.393712754493, 5053.393592768891, 5055.898882022412, 4866.0, 5015.899682006412, 5041.319421878146, 5072.4673909239, 5082.593392528663, 4956.628252881121, 5019.949800501949, 5061.772220250024, 5065.214891691794, 5068.569171620454, 4953.3065370848835, 5042.899142017212, 5053.267276244997, 5063.8480845574695, 5085.0, 4965.1807451770055, 5006.4743201963265, 5017.197248440232, 5041.168207245763, 5059.114654935445], "value": 4765.26663564681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.5262534836115, 580.8722081142147, 586.870888404551, 593.6497466494767, 603.1435361786262, 26651.333716657093, 39430.80284598577, 40522.18955620886, 40559.79720101399, 44143.55856441434, 39849.800750996204, 40211.798941005254, 40400.39399409011, 40425.797871010676, 40450.190996180056, 7901.999999999985, 7918.2477664621765, 7971.322437592811, 7989.520628762264, 7994.800129996767, 7795.766127016199, 7869.685212591489, 7894.250046245597, 7896.447248692594, 7899.802504937394, 7938.24586664266, 7976.920230797676, 8019.398545109111, 8021.518708877456, 8022.19778022196, 7952.681892724313, 7968.44220904534, 7997.760067197935, 7997.920020799776, 8003.599820009034, 7934.246246606564, 7981.321587665056, 8003.399745019147, 8006.599670016534, 8008.079070906862, 38491.80754096239, 38598.614013859784, 38635.22729545421, 38645.613543864485, 38683.41974870379, 3113.8131712097347, 3308.3217940322174, 3332.683395077464, 3441.776284541497, 3501.1422201560526, 29328.26679333034, 29772.70227297721, 30183.342794259785, 30666.23334416635, 31071.84464077688, 3280.8687652493873, 3313.5858017747782, 3348.0123363607795, 3355.328934213167, 3413.1296519387647, 181370.0, 181388.0, 181600.0, 181646.0, 183104.99999999866, 27675.584866227022, 28247.717522824507, 28305.43389132206, 51120.0, 51937.48062519402, 33893.322133557194, 34113.829430853184, 34114.48828267578, 34123.4881476778, 34155.316893662486, 13176.341182940814, 13257.138286011379, 13257.270850103145, 13260.403281852146, 13270.203787772765, 10891.074258687942, 10919.181061420426, 10919.672409827559, 10920.836187457195, 10928.125749939985, 7930.206979302139, 7941.324987376138, 7942.920570794334, 8000.319972802261, 8008.079070906804, 3108.673589273139, 3148.0, 3173.571567838312, 3173.7302329301806, 3206.2785873178814, 813.9552324622202, 843.9156084391511, 888.8400637168428, 954.651552183462, 1013.7668336282696, 26369.47261054768, 27472.0, 27618.171454856387, 27686.307842304104, 27722.445551088866, 780.5043797188825, 927.5269612497675, 944.9935818353432, 962.3552220012608, 974.6101559376306, 14324.283785810669, 14572.271386430848, 14811.0, 14911.254437278092, 15028.474003410047, 374749.0, 378081.0, 380702.0, 381273.0, 382256.0, 48115.5188448111, 48560.5143948556, 48615.27077093846, 48705.0, 48751.75624121928, 1087.8313861351344, 1161.5528021711532, 1197.5209916033657, 1214.6963259185204, 1214.7995580729257, 28019.159425217276, 29402.0, 29821.0, 29874.551881722226, 30009.399812004074, 36547.26905461929, 36576.0, 36902.446463302535, 36970.44544331891, 37009.81495092507, 295836.0, 296527.0, 297156.0, 298401.0, 538467.0, 24798.876005619855, 25479.49041019132, 25508.489830203664, 26715.465690685687, 26725.599116012887, 42228.0, 42920.570794291656, 43208.135837283706, 44337.11325773402, 48501.27248091352, 36230.0, 37264.44103338398, 37597.248055039294, 37687.0, 37719.245615087, 36417.27165456623, 36515.817420912725, 36600.63399366079, 36745.08137296482, 37090.814545927096, 35677.46483802797, 35835.64164358323, 36210.8189459051, 36497.45253821248, 36699.44950825793, 29508.114756557337, 29911.55132673055, 29999.100026999226, 30360.696393035785, 30392.544111838783, 25283.771423430684, 25810.741892580834, 25905.611415829153, 26112.73887261103, 26352.736472635796], "value": 16235.031619670317, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.2379792818506, 378.5495260639838, 384.71531067010403, 390.7948327128259, 394.1093129527267, 15614.86382443957, 16915.0, 17376.913115434436, 17569.82430175698, 17629.382971595966, 15591.92204038981, 16742.330306787713, 17161.742573861404, 17238.310467581283, 17252.568685782862, 4511.030128522367, 4659.324397962293, 4733.66864319496, 4735.242361222206, 4735.242361222206, 3481.3733527964955, 5118.692878427306, 5417.566594672437, 5419.078756611386, 5487.396386397493, 5377.973110134463, 5450.182472629098, 5465.863353416176, 5483.8080667176655, 5487.533559647435, 5294.258803767476, 5401.756920938567, 5404.5946554008215, 5409.594280428983, 5475.589330800186, 3368.6126095499085, 4981.402231732179, 5355.678659280456, 5359.169328754049, 5412.729363531807, 11930.880691193064, 12091.45588448522, 12094.818577721342, 17309.826901730947, 20459.158675719256, 1932.6424611446928, 1988.453175376783, 1999.2902519605475, 2011.8491113166424, 2023.4840115770385, 8721.912780872173, 9063.637454501812, 9085.636574537011, 9258.120478554527, 9646.710598682052, 1719.6216832296875, 1728.888756254544, 1740.0, 1774.104077440884, 1814.8185181481879, 65868.6706566469, 67871.0, 68540.0, 68763.65618171927, 70304.64847675832, 9837.754056148653, 9927.553260103312, 10205.285630005828, 10252.58989640421, 10974.615888443866, 13809.51666691661, 13884.444622214998, 13968.511102111377, 13970.650733731738, 14017.5093871714, 6790.660466976631, 7057.576545407292, 7173.6771845267085, 7230.74692385764, 7235.204127545966, 6582.17722784652, 6601.405873471411, 6754.0, 6773.491988100912, 6773.559718618274, 4354.608085272341, 4441.822327106879, 4455.598996090367, 4527.275635898241, 4583.9083218335445, 1698.41404715373, 1763.6560870630103, 1830.304484295959, 1834.4313262888547, 1835.5227640813484, 736.4108713029555, 757.3903008078439, 860.5783166248493, 894.673444192865, 910.0808183734343, 15923.363065477251, 16588.75116873248, 16636.67086607876, 16700.58248543796, 16803.07583082942, 833.795720048592, 858.7037472072125, 862.1766213266316, 871.4684042733927, 885.7564169853213, 9451.952740236255, 9774.609015639437, 9797.118259356692, 9835.262355323379, 9840.16358609512, 363006.0, 367579.0, 371143.0, 372340.5531889347, 380772.0, 47379.05241895212, 54113.72943135338, 75272.0, 77812.61093694496, 78234.47944842496, 857.6783706110209, 867.9218870301703, 875.282268539804, 895.4403497813867, 934.4486752815735, 15693.529194124194, 16005.839941600434, 16069.678606427573, 16125.67748645044, 16304.51086467408, 30869.228269293446, 33067.338653227285, 38448.80775596104, 38855.222895542494, 39686.404703928885, 51839.74080129575, 52333.0, 53336.1999569999, 53986.46013539971, 54538.0, 7682.347000504796, 7724.459287850022, 7945.364370850433, 7983.760487185394, 7990.360771138178, 10460.79078418412, 11772.352520611106, 11912.225705329125, 12232.204906681038, 12255.080868935043, 9807.803843923224, 9814.852777208205, 9944.0, 10093.5457904393, 10208.540615672164, 9722.854157187507, 9935.751606209902, 10154.949225253826, 10385.948070259601, 10709.08972737326, 10006.249531285037, 10112.191024718151, 10441.895581044093, 10498.47507624631, 10621.681349559525, 7605.88591171144, 7885.093214280431, 7948.125706172432, 8003.079645840803, 8047.1550487198, 9759.121679048636, 10089.89910100919, 10556.208284378856, 10826.350418974887, 11009.61466348674], "value": 8050.468098954529, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1187.7446349034956, 1272.4719241514772, 1337.8260826092605, 1350.2101270756607, 1648.2006226979913, 7338.266173382665, 7650.0, 7700.229977002304, 7941.483803552765, 7972.322352600036, 7589.392848572114, 7730.768076957686, 7737.22627737226, 7744.92255077449, 7780.533168009923, 1896.6111947050822, 1956.2664000999625, 1958.7551556055494, 2186.2348178137645, 2229.576380487702, 1950.570874407628, 2154.5798569278995, 2234.9888250558724, 2237.272886311947, 2238.7425446073667, 2188.3763127508664, 2208.216083290433, 2221.822254219667, 2227.2538699535676, 2228.2869481765842, 1855.8236967488067, 2153.6661817418326, 2160.0495781855934, 2163.9675404868863, 2165.0798410675557, 2120.7455105387453, 2183.443221978401, 2185.8360622953182, 2186.6173419651655, 2188.616992026389, 7887.645055972495, 7935.206479352077, 7950.403719720986, 7950.840983180362, 7951.125376208613, 4502.729836209838, 4649.1399091167905, 4651.44182698075, 4654.720716756971, 4654.767261636938, 2804.957925631117, 2875.151830210093, 2885.9134225973253, 2903.274181454636, 2936.721011503904, 877.5875338590852, 894.0612357025162, 898.6540182029966, 921.0927236671873, 923.1507013547553, 10727.141828653688, 10752.032317091422, 10757.83863242052, 10770.515326810233, 10777.622783202629, 4037.313656678372, 4129.112240868228, 4221.092465119953, 4221.2190744712325, 4222.345536441856, 9211.217046550984, 9241.815163696689, 9242.012967212082, 9254.907450925539, 9255.120763527455, 4647.883802904955, 4656.208444564364, 4689.437267527918, 4714.5992590630185, 4715.127701375257, 3615.8192090395373, 3621.8008009559726, 4178.895527611773, 4235.682323825726, 4236.068065025689, 3558.3061303046175, 3713.8700145494777, 3730.1047748540154, 3772.7359084863797, 3784.0729021389934, 1176.1355403778216, 1194.976100478003, 1199.5681554640323, 1212.5513559982687, 1215.8115492098561, 775.6897241103603, 832.1137988042836, 859.8968123825181, 871.5729292646685, 889.2619126125301, 5193.870153246199, 5283.9471605284225, 5417.3770016447825, 5529.778808847682, 5589.301337332833, 406.51827584312684, 413.4542404026656, 416.2008942829774, 419.3458205199898, 437.0712236497443, 3566.3045706087582, 3666.9816650916573, 3670.596234414212, 3706.314331848617, 3747.5315585551807, 9246.815063698688, 9449.90550094504, 9462.810743785223, 9567.760805979768, 9592.9040709592, 9475.05249475047, 9496.620135194515, 9516.000819913948, 9527.523623818919, 9555.713328600154, 7151.7854464366155, 7195.208527062124, 7231.63841807918, 7245.166805817293, 7265.782026539212, 5451.836444906659, 5513.145462453326, 5532.699815543425, 5616.747246373841, 5633.971830140987, 8802.91197088021, 8900.06549312313, 9037.68368107113, 9046.638134474548, 9060.365774395728, 8701.0, 9040.0, 9212.769680758034, 9222.907770922206, 9223.308251881002, 6139.662318572343, 6332.493400527855, 6335.968320158369, 6835.248122706597, 6923.965380173268, 6897.620630865351, 7131.144262688511, 7311.195768465358, 7354.080739907512, 7497.662605182671, 6647.335266473314, 6666.699998500176, 6769.356911093439, 6829.146356705412, 6884.965575172092, 6494.253160886369, 6526.738930442919, 6577.967110164419, 6614.239362473377, 6685.799426017227, 5978.4021597839865, 6017.458428741435, 6040.1543783871175, 6047.123167140828, 6052.667103309184, 4588.747618880993, 4633.814647414066, 4688.226442636927, 4755.048990201904, 4846.733429661403, 4784.569388755029, 4812.903741925212, 4899.583535399531, 4918.852434426973, 4946.802127914843], "value": 4045.9240128381316, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.5913437292469, 303.87541108145666, 304.6466099324782, 305.9556364327172, 312.640463467013, 4881.0969970555425, 4898.093852637265, 4922.483139270379, 4926.876828079296, 4940.925886111711, 4840.596227094147, 4852.369192005043, 4860.878478038051, 4886.998165376098, 4897.902041959159, 3681.153334733013, 3792.4500947362617, 3807.8476860925666, 3808.447775072613, 3829.4447305140875, 3652.689521390685, 3810.7523011004337, 3815.0271680721376, 3851.4993050903345, 3855.9807200963955, 3692.833822477995, 3729.1982223821874, 3779.622037796212, 3798.810059497028, 3813.8474461021524, 3585.748997570171, 3761.661450469457, 3787.6780473659774, 3797.39241721326, 3830.8276127574327, 3314.486254630536, 3320.9501857472155, 3333.5499707539416, 3340.914202884048, 3344.180675734436, 4727.929081063787, 4737.952620473786, 4755.619550435957, 4764.2615394613895, 4768.737719425465, 4310.418093557392, 4316.762578058206, 4331.696781225315, 4333.1766964276685, 4339.47926248849, 4920.434150072751, 5046.839226977779, 5056.292119103328, 5075.340205773263, 5101.591872650179, 3597.334493118781, 3607.6392360763975, 3609.350316942949, 3615.783053016801, 3637.909052273714, 5276.551493123051, 5316.623943795717, 5321.813736519242, 5345.0, 5371.597130215249, 3601.3877640801124, 3674.0080178351695, 3677.8712745053795, 3692.0, 3702.7593206441493, 3731.9626803731617, 3732.234891847165, 3753.5683396409217, 3757.3236817373136, 3767.1900541383184, 4202.915941681211, 4208.075387605585, 4242.300020496584, 4246.40550322955, 4253.63844073251, 4831.903361932742, 5067.822626208065, 5067.822626208065, 5070.340855688737, 5113.28995632308, 1297.3642914971786, 1311.4491913396396, 1311.9344032798322, 1313.487739781486, 1317.5586178630074, 806.3790881021698, 825.7316372179066, 827.611022819274, 835.1398059998212, 843.5234092737584, 4312.741235525878, 4508.752018638941, 4517.412736344254, 4559.4072770539615, 4562.6996306052615, 5233.712145832016, 5278.868028299246, 5283.4452382499285, 5284.678830292427, 5286.894262114736, 4506.887327816831, 4515.932261016087, 4521.457425109008, 4522.773861306921, 4534.891275556882, 2618.0574993002883, 2778.9861050694617, 2817.9859100704775, 2832.6459192600923, 2832.702566230516, 4933.975330123327, 4969.801207951714, 4976.2038073908, 4996.175631020841, 5014.0, 5184.0, 5300.257963885059, 5317.404778566414, 5335.866603334947, 5346.599005074635, 4899.3385892904, 4900.534449227318, 4901.632377571767, 4922.852314430501, 4950.43070046942, 5236.554892834151, 5239.109351410193, 5249.133892907627, 5250.18622113573, 5257.526822585985, 4953.365389421554, 5024.568077349951, 5079.822206222764, 5141.614378921521, 5144.30551875507, 4898.657094003385, 4901.995091006406, 4930.742660621519, 4946.15915294408, 4970.179920313252, 3386.7629265951145, 3408.2672225471642, 3492.9825350873084, 3498.8600455981477, 3499.3001399720665, 4642.628589712883, 4720.480747117883, 4796.66423350376, 4818.879528011687, 4958.404991401055, 5134.666246693953, 5159.484051594811, 5168.276441298296, 5168.3539557555305, 5170.508801663836, 5115.9232611510115, 5117.974410127926, 5124.871878203075, 5159.226116082467, 5172.043172013189, 4865.878353041061, 5073.365829271341, 5081.92377114351, 5095.363079615048, 5101.591872650253, 4943.555080042814, 5037.596992240538, 5079.3650793650795, 5092.439831618445, 5199.168133098686, 5016.498350164954, 5022.020705962303, 5024.42219144803, 5040.521150490697, 5049.621278404208], "value": 3819.397957004314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.7861510871778, 669.4376723552215, 701.8736627407067, 712.693541777036, 726.960017199054, 12609.684757881058, 13255.40350684219, 13633.0, 13989.370478328474, 13995.020348575617, 13548.72902541951, 13549.254790986492, 13743.725125497484, 13746.93126534366, 13762.174269543835, 627.6673363117555, 637.2257706886132, 639.1275908385068, 766.5477368352671, 791.5092642561619, 639.1722719078804, 773.5861314196906, 774.248978490863, 778.8091917480197, 783.8706613408809, 817.5503473089807, 819.0212695828487, 821.0926925747024, 822.6914906909909, 823.6993497373445, 646.9094326794252, 820.5979070255592, 821.4250024982476, 821.5153059694809, 822.9341652667803, 589.0722112672557, 594.7323704333024, 600.504583718434, 601.8344955137328, 604.927408710953, 11684.591039313667, 11716.355600441972, 11722.58970936013, 11741.589044383405, 11744.765104697944, 12352.814707779391, 12838.55065072718, 12891.87108128916, 13171.407286672124, 13322.134061286082, 11616.88383116175, 11631.6510504685, 11859.40702964857, 12023.27860328383, 12217.93891030539, 4099.405586189986, 4152.626263636287, 4168.145530166339, 4280.743155410685, 4284.186004659136, 63052.36947630511, 63131.68434157846, 63413.68293158551, 64190.999999999534, 64303.0, 9429.48137852411, 9586.66446674377, 9648.517574121266, 9950.950245248727, 9989.350692204984, 17870.731939020927, 17943.820561794215, 17951.640967180585, 17954.012529310752, 17977.280908763765, 6301.6219026858535, 6346.904796428057, 6427.614343139427, 6469.417752402306, 6570.507211959122, 3772.9434058489146, 3780.0360907968293, 3826.1199924017633, 3855.306044911943, 3872.651461368434, 2629.618705287761, 2722.4555088982283, 2729.3449572102554, 2731.1260396672874, 2733.494303553809, 506.65294273422825, 522.3288074823909, 525.7056048612789, 527.380328114464, 539.3366159623606, 529.8278059630635, 552.2847911954029, 556.2796178948272, 561.0406205388831, 584.8303991842319, 7414.555126692416, 7416.7404140854815, 7613.155356544909, 7619.885701714478, 7781.766547003599, 436.99273175330535, 444.7220487195503, 485.19215506181814, 516.5841497594397, 551.6938099354817, 3420.863165473403, 3593.1017245688577, 3613.765105268149, 3647.76289541179, 3744.475773391727, 77587.61206193933, 77940.0, 80670.0, 80791.0, 95732.0, 49119.0, 49487.0, 49973.75013124911, 50000.24999625009, 50873.491265087614, 72656.0, 74711.62644186744, 74981.25018749743, 77489.612551938, 78703.0, 8759.12408759119, 8798.604062817061, 8805.735827925173, 8872.822543549222, 8895.599698013735, 42294.57705423029, 43139.784301078296, 44079.33880991724, 44609.330860036476, 44621.33068003917, 58428.0, 61853.0, 62165.68917155566, 62213.68893155505, 62243.37756622376, 11975.520979160736, 12156.392180391122, 12177.452014659539, 12468.875311246771, 12926.547570834975, 11785.410729463663, 11862.82205766897, 12286.692832678897, 13476.93261533686, 13699.315034248448, 9167.23303881991, 12274.525964579381, 12910.741785164057, 12916.935415322863, 13590.388432520362, 12178.208416452902, 12263.141580089308, 12357.32034738062, 12387.256764594153, 12524.812127817908, 11553.422328883691, 11668.416579171177, 11961.700957476132, 11999.0, 12112.454939527566, 9328.860067099135, 10649.733756656145, 10655.30740501865, 10689.893101069201, 10920.945395272973, 10248.669261937002, 10765.30025548337, 10807.13542916549, 10817.459127043774, 10970.725731856768], "value": 6435.321030046572, "unit": "score"}], "name": "dromaeo_css", "value": 6290.208932820503, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 113.0, 113.0, 112.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 134.0, 180.0, 130.0, 131.0, 156.0, 129.0, 178.0, 133.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 162.0, 162.0, 161.0, 164.0, 163.0, 164.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 108.0, 77.0, 78.0, 74.0, 75.0, 98.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 117.0, 85.0, 86.0, 86.0, 113.0, 85.0, 87.0, 124.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 63.0, 63.0, 63.0, 63.0, 67.0, 63.0, 64.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 83.0, 87.0, 84.0, 84.0, 85.0, 111.0, 83.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 128.0, 129.0, 132.0, 140.0, 129.0, 134.0, 138.0, 138.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 178.0, 169.0, 169.0, 169.0, 170.0, 166.0, 169.0, 168.0, 175.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 69.0, 67.0, 70.0, 71.0, 69.0, 66.0, 66.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1545.4, "alertThreshold": 2.0}]} 01:19:23 INFO - Return code: 0 01:19:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:19:23 INFO - # TBPL SUCCESS # 01:19:23 INFO - Running post-action listener: _resource_record_post_action 01:19:23 INFO - ##### 01:19:23 INFO - ##### Finished run-tests step (success) 01:19:23 INFO - ##### 01:19:23 INFO - Running post-run listener: _resource_record_post_run 01:19:23 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 6049792; Write bytes: 452018176; Read time: 1252; Write time: 422028 01:19:23 INFO - TinderboxPrint: CPU usage
13.1% 01:19:23 INFO - TinderboxPrint: I/O read bytes / time
6,049,792 / 1,252 01:19:23 INFO - TinderboxPrint: I/O write bytes / time
452,018,176 / 422,028 01:19:23 INFO - TinderboxPrint: CPU idle
8,351.7 (86.8%) 01:19:23 INFO - TinderboxPrint: CPU user
1,215.5 (12.6%) 01:19:23 INFO - TinderboxPrint: Swap in / out
0 / 0 01:19:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107458560; Read time: 0; Write time: 104960 01:19:23 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 6045696; Write bytes: 344559616; Read time: 1244; Write time: 317068 01:19:24 INFO - Running post-run listener: _upload_blobber_files 01:19:24 INFO - Blob upload gear active. 01:19:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:19:24 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:19:24 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:19:24 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:19:24 INFO - (blobuploader) - INFO - Open directory for files ... 01:19:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:19:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:19:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:19:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:19:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:19:25 INFO - (blobuploader) - INFO - Done attempting. 01:19:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:19:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:19:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:19:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:19:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:19:26 INFO - (blobuploader) - INFO - Done attempting. 01:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:19:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:19:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:19:29 INFO - (blobuploader) - INFO - Done attempting. 01:19:29 INFO - (blobuploader) - INFO - Iteration through files over. 01:19:29 INFO - Return code: 0 01:19:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:19:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:19:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf3d46d83a156fc7a190b0606c4e4d9713f82bfff59cf47363eeabfc7a3e1d54847bc9beedfa10342175950de8c6116d26abe312351bb371e6f810e740b12169", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea76b0f6698af927943e93486c7dbfef8bd7e8c130a23ea490c20752e5d76a1a329e24eef4c93a3b750ddd89a44e99479e8198e1f6116e781f2d91e436337fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eec3b8062ab15b0cbb2cf866069c299c2f5ee20b372eb589eeaf5fe3d17acf4b0a13744ec6a35d5211f18f57a0552b352e455903d6264915ee72e7660f0b9d7b"} 01:19:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:19:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:19:29 INFO - Contents: 01:19:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf3d46d83a156fc7a190b0606c4e4d9713f82bfff59cf47363eeabfc7a3e1d54847bc9beedfa10342175950de8c6116d26abe312351bb371e6f810e740b12169", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea76b0f6698af927943e93486c7dbfef8bd7e8c130a23ea490c20752e5d76a1a329e24eef4c93a3b750ddd89a44e99479e8198e1f6116e781f2d91e436337fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eec3b8062ab15b0cbb2cf866069c299c2f5ee20b372eb589eeaf5fe3d17acf4b0a13744ec6a35d5211f18f57a0552b352e455903d6264915ee72e7660f0b9d7b"} 01:19:29 INFO - Running post-run listener: copy_logs_to_upload_dir 01:19:29 INFO - Copying logs to upload dir... 01:19:29 INFO - mkdir: /builds/slave/test/build/upload/logs 01:19:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.903706 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-22 01:19:29.850754) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:29.854540) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547 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/bf3d46d83a156fc7a190b0606c4e4d9713f82bfff59cf47363eeabfc7a3e1d54847bc9beedfa10342175950de8c6116d26abe312351bb371e6f810e740b12169", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea76b0f6698af927943e93486c7dbfef8bd7e8c130a23ea490c20752e5d76a1a329e24eef4c93a3b750ddd89a44e99479e8198e1f6116e781f2d91e436337fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eec3b8062ab15b0cbb2cf866069c299c2f5ee20b372eb589eeaf5fe3d17acf4b0a13744ec6a35d5211f18f57a0552b352e455903d6264915ee72e7660f0b9d7b"} build_url:https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/BLqnhGGERs-u-BHq1fGjXA/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/bf3d46d83a156fc7a190b0606c4e4d9713f82bfff59cf47363eeabfc7a3e1d54847bc9beedfa10342175950de8c6116d26abe312351bb371e6f810e740b12169", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea76b0f6698af927943e93486c7dbfef8bd7e8c130a23ea490c20752e5d76a1a329e24eef4c93a3b750ddd89a44e99479e8198e1f6116e781f2d91e436337fb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eec3b8062ab15b0cbb2cf866069c299c2f5ee20b372eb589eeaf5fe3d17acf4b0a13744ec6a35d5211f18f57a0552b352e455903d6264915ee72e7660f0b9d7b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:29.880056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:29.880392) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1466581355.150693-502079547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:29.963203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 01:19:29.963513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 01:19:29.963809) ========= ========= Total master_lag: 0.21 =========