builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1464293268.92 results: success (0) buildid: 20160526123752 builduid: f4dfe022ce674f02b5fabed132505126 revision: 6a6155e3afa6148ef93255e6d9e126c2974f0319 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:48.919105) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:48.919736) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:48.920199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:48.941079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:48.941387) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 13:07:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-05-26 13:07:49 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:49.048613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:49.049015) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017891 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:49.100560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:49.100936) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a6155e3afa6148ef93255e6d9e126c2974f0319 --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 6a6155e3afa6148ef93255e6d9e126c2974f0319 --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=a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 13:07:49,375 truncating revision to first 12 chars 2016-05-26 13:07:49,375 Setting DEBUG logging. 2016-05-26 13:07:49,375 attempt 1/10 2016-05-26 13:07:49,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a6155e3afa6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 13:07:49,683 unpacking tar archive at: fx-team-6a6155e3afa6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629507 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:49.744748) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:49.745054) ========= script_repo_revision: 6a6155e3afa6148ef93255e6d9e126c2974f0319 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:49.745482) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:49.745766) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 13:07:49.762779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-26 13:07:49.763096) ========= /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=a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:07:50 INFO - MultiFileLogger online at 20160526 13:07:50 in /builds/slave/test 13:07:50 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 13:07:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:50 INFO - {'append_to_log': False, 13:07:50 INFO - 'base_work_dir': '/builds/slave/test', 13:07:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:07:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:50 INFO - 'branch': 'Fx-Team-Non-PGO', 13:07:50 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:50 INFO - 'config_files': ('talos/linux_config.py',), 13:07:50 INFO - 'default_actions': ('clobber', 13:07:50 INFO - 'read-buildbot-config', 13:07:50 INFO - 'download-and-extract', 13:07:50 INFO - 'populate-webroot', 13:07:50 INFO - 'create-virtualenv', 13:07:50 INFO - 'install', 13:07:50 INFO - 'run-tests'), 13:07:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:50 INFO - 'download_minidump_stackwalk': True, 13:07:50 INFO - 'download_symbols': 'ondemand', 13:07:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:50 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:50 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:50 INFO - 'installer_path': 'installer.exe', 13:07:50 INFO - 'log_level': 'info', 13:07:50 INFO - 'log_name': 'talos', 13:07:50 INFO - 'log_to_console': True, 13:07:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:07:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:07:50 INFO - 'opt_config_files': (), 13:07:50 INFO - 'pip_index': False, 13:07:50 INFO - 'sps_profile': False, 13:07:50 INFO - 'sps_profile_interval': 0, 13:07:50 INFO - 'suite': 'dromaeojs', 13:07:50 INFO - 'system_bits': '32', 13:07:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:50 INFO - 'title': 'talos-linux64-ix-002', 13:07:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:50 INFO - 'use_talos_json': True, 13:07:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:50 INFO - 'work_dir': 'build'} 13:07:50 INFO - ##### 13:07:50 INFO - ##### Running clobber step. 13:07:50 INFO - ##### 13:07:50 INFO - Running pre-action listener: _resource_record_pre_action 13:07:50 INFO - Running main action method: clobber 13:07:50 INFO - rmtree: /builds/slave/test/build 13:07:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:50 INFO - Running post-action listener: _resource_record_post_action 13:07:50 INFO - ##### 13:07:50 INFO - ##### Finished clobber step (success) 13:07:50 INFO - ##### 13:07:50 INFO - ##### 13:07:50 INFO - ##### Running read-buildbot-config step. 13:07:50 INFO - ##### 13:07:50 INFO - Running pre-action listener: _resource_record_pre_action 13:07:50 INFO - Running main action method: read_buildbot_config 13:07:50 INFO - Using buildbot properties: 13:07:50 INFO - { 13:07:50 INFO - "project": "", 13:07:50 INFO - "product": "firefox", 13:07:50 INFO - "script_repo_revision": "production", 13:07:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:07:50 INFO - "repository": "", 13:07:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:07:50 INFO - "buildid": "20160526123752", 13:07:50 INFO - "pgo_build": "False", 13:07:50 INFO - "basedir": "/builds/slave/test", 13:07:50 INFO - "buildnumber": 3010, 13:07:50 INFO - "slavename": "talos-linux64-ix-002", 13:07:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:07:50 INFO - "platform": "ubuntu64_hw", 13:07:50 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:07:50 INFO - "branch": "fx-team", 13:07:50 INFO - "repo_path": "integration/fx-team", 13:07:50 INFO - "revision": "6a6155e3afa6148ef93255e6d9e126c2974f0319", 13:07:50 INFO - "stage_platform": "linux64", 13:07:50 INFO - "builduid": "f4dfe022ce674f02b5fabed132505126", 13:07:50 INFO - "slavebuilddir": "test" 13:07:50 INFO - } 13:07:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:07:50 INFO - Running post-action listener: _resource_record_post_action 13:07:50 INFO - ##### 13:07:50 INFO - ##### Finished read-buildbot-config step (success) 13:07:50 INFO - ##### 13:07:50 INFO - ##### 13:07:50 INFO - ##### Running download-and-extract step. 13:07:50 INFO - ##### 13:07:50 INFO - Running pre-action listener: _resource_record_pre_action 13:07:50 INFO - Running main action method: download_and_extract 13:07:50 INFO - mkdir: /builds/slave/test/build/tests 13:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:50 INFO - https://queue.taskcluster.net/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:07:52 INFO - Downloaded 1361 bytes. 13:07:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:07:52 INFO - Using the following test package requirements: 13:07:52 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:07:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:07:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:52 INFO - u'jsshell-linux-x86_64.zip'], 13:07:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:07:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:07:52 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:07:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:07:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:07:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:52 INFO - https://queue.taskcluster.net/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:07:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:07:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:07:53 INFO - Downloaded 22835570 bytes. 13:07:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:07:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:07:55 INFO - Return code: 0 13:07:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:07:55 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')]} 13:07:55 INFO - https://queue.taskcluster.net/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:07:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:07:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:07:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:08:03 INFO - Downloaded 22835570 bytes. 13:08:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:08:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:08:04 INFO - Return code: 0 13:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:04 INFO - https://queue.taskcluster.net/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:08:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:08:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:08:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:08:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:08:08 INFO - Downloaded 10834034 bytes. 13:08:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:08:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:08:09 INFO - Return code: 0 13:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:09 INFO - https://queue.taskcluster.net/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:08:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:08:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:08:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:08:10 INFO - Downloaded 54829072 bytes. 13:08:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:08:10 INFO - mkdir: /builds/slave/test/properties 13:08:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:08:10 INFO - Writing to file /builds/slave/test/properties/build_url 13:08:10 INFO - Contents: 13:08:10 INFO - build_url:https://queue.taskcluster.net/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:08:11 INFO - Running post-action listener: _resource_record_post_action 13:08:11 INFO - Running post-action listener: set_extra_try_arguments 13:08:11 INFO - ##### 13:08:11 INFO - ##### Finished download-and-extract step (success) 13:08:11 INFO - ##### 13:08:11 INFO - ##### 13:08:11 INFO - ##### Running populate-webroot step. 13:08:11 INFO - ##### 13:08:11 INFO - Running pre-action listener: _resource_record_pre_action 13:08:11 INFO - Running main action method: populate_webroot 13:08:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:08:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:08:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:08:11 INFO - '--tppagecycles', 13:08:11 INFO - '7'], 13:08:11 INFO - 'tests': ['tsvgm']}}, 13:08:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:08:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:08:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:08:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:08:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:08:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:08:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:11 INFO - 'talos_options': ['--disable-e10s'], 13:08:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:11 INFO - 'talos_options': ['--disable-e10s'], 13:08:11 INFO - 'tests': ['damp', 'tps']}, 13:08:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:11 INFO - 'tests': ['damp', 'tps']}, 13:08:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:08:11 INFO - 'tests': ['dromaeo_dom']}, 13:08:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:08:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:08:11 INFO - 'tests': ['a11yr', 13:08:11 INFO - 'ts_paint', 13:08:11 INFO - 'tpaint', 13:08:11 INFO - 'sessionrestore', 13:08:11 INFO - 'sessionrestore_no_auto_restore', 13:08:11 INFO - 'tabpaint']}, 13:08:11 INFO - 'other-e10s': {'tests': ['a11yr', 13:08:11 INFO - 'ts_paint', 13:08:11 INFO - 'tpaint', 13:08:11 INFO - 'sessionrestore', 13:08:11 INFO - 'sessionrestore_no_auto_restore', 13:08:11 INFO - 'tabpaint']}, 13:08:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:08:11 INFO - 'ts_paint', 13:08:11 INFO - 'tpaint', 13:08:11 INFO - 'sessionrestore', 13:08:11 INFO - 'sessionrestore_no_auto_restore', 13:08:11 INFO - 'tabpaint']}, 13:08:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:08:11 INFO - 'ts_paint', 13:08:11 INFO - 'tpaint', 13:08:11 INFO - 'sessionrestore', 13:08:11 INFO - 'sessionrestore_no_auto_restore', 13:08:11 INFO - 'tabpaint']}, 13:08:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:08:11 INFO - 'tests': ['a11yr', 13:08:11 INFO - 'ts_paint', 13:08:11 INFO - 'tpaint', 13:08:11 INFO - 'sessionrestore', 13:08:11 INFO - 'sessionrestore_no_auto_restore', 13:08:11 INFO - 'tabpaint']}, 13:08:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:08:11 INFO - 'tests': ['a11yr', 13:08:11 INFO - 'ts_paint', 13:08:11 INFO - 'tpaint', 13:08:11 INFO - 'sessionrestore', 13:08:11 INFO - 'sessionrestore_no_auto_restore', 13:08:11 INFO - 'tabpaint']}, 13:08:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:08:11 INFO - 'tests': ['tsvgx', 13:08:11 INFO - 'tsvgr_opacity', 13:08:11 INFO - 'tart', 13:08:11 INFO - 'tscrollx', 13:08:11 INFO - 'cart']}, 13:08:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:08:11 INFO - 'tsvgr_opacity', 13:08:11 INFO - 'tart', 13:08:11 INFO - 'tscrollx', 13:08:11 INFO - 'cart']}, 13:08:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:11 INFO - 'talos_options': ['--disable-e10s'], 13:08:11 INFO - 'tests': ['tp5o']}, 13:08:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:11 INFO - 'tests': ['tp5o']}, 13:08:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:11 INFO - 'talos_options': ['--disable-e10s', 13:08:11 INFO - '--xperf_path', 13:08:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:11 INFO - 'tests': ['tp5n']}, 13:08:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:11 INFO - 'talos_options': ['--xperf_path', 13:08:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:11 INFO - 'tests': ['tp5n']}}, 13:08:11 INFO - 'talos.zip': {'path': '', 13:08:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:08:11 INFO - Running post-action listener: _resource_record_post_action 13:08:11 INFO - ##### 13:08:11 INFO - ##### Finished populate-webroot step (success) 13:08:11 INFO - ##### 13:08:11 INFO - ##### 13:08:11 INFO - ##### Running create-virtualenv step. 13:08:11 INFO - ##### 13:08:11 INFO - Running pre-action listener: _resource_record_pre_action 13:08:11 INFO - Running main action method: create_virtualenv 13:08:11 INFO - Creating virtualenv /builds/slave/test/build/venv 13:08:11 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 13:08:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:08:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:08:11 INFO - Using real prefix '/usr' 13:08:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:08:11 INFO - Installing distribute.............................................................................................................................................................................................done. 13:08:13 INFO - Installing pip.................done. 13:08:13 INFO - Return code: 0 13:08:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe03e15df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edf9c0>, '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 0x1ee08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', '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 13:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:08:13 INFO - Using env: {'DISPLAY': ':0', 13:08:13 INFO - 'HOME': '/home/cltbld', 13:08:13 INFO - 'LANG': 'en_US.UTF-8', 13:08:13 INFO - 'LANGUAGE': 'en_US:en', 13:08:13 INFO - 'LOGNAME': 'cltbld', 13:08:13 INFO - 'MAIL': '/var/mail/cltbld', 13:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:13 INFO - 'MOZ_NO_REMOTE': '1', 13:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:13 INFO - 'NO_EM_RESTART': '1', 13:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:13 INFO - 'PWD': '/builds/slave/test', 13:08:13 INFO - 'SHELL': '/bin/bash', 13:08:13 INFO - 'SHLVL': '1', 13:08:13 INFO - 'TERM': 'linux', 13:08:13 INFO - 'TMOUT': '86400', 13:08:13 INFO - 'USER': 'cltbld', 13:08:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', 13:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:13 INFO - '_': '/tools/buildbot/bin/python'} 13:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:13 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 13:08:13 INFO - Cleaning up... 13:08:13 INFO - Return code: 0 13:08:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe03e15df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edf9c0>, '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 0x1ee08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', '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 13:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:08:13 INFO - Using env: {'DISPLAY': ':0', 13:08:13 INFO - 'HOME': '/home/cltbld', 13:08:13 INFO - 'LANG': 'en_US.UTF-8', 13:08:13 INFO - 'LANGUAGE': 'en_US:en', 13:08:13 INFO - 'LOGNAME': 'cltbld', 13:08:13 INFO - 'MAIL': '/var/mail/cltbld', 13:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:13 INFO - 'MOZ_NO_REMOTE': '1', 13:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:13 INFO - 'NO_EM_RESTART': '1', 13:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:13 INFO - 'PWD': '/builds/slave/test', 13:08:13 INFO - 'SHELL': '/bin/bash', 13:08:13 INFO - 'SHLVL': '1', 13:08:13 INFO - 'TERM': 'linux', 13:08:13 INFO - 'TMOUT': '86400', 13:08:13 INFO - 'USER': 'cltbld', 13:08:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', 13:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:13 INFO - '_': '/tools/buildbot/bin/python'} 13:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:14 INFO - Downloading/unpacking psutil>=3.1.1 13:08:14 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 13:08:14 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 13:08:14 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 13:08:14 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 13:08:14 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 13:08:14 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 13:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:08:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:16 INFO - Installing collected packages: psutil 13:08:16 INFO - Running setup.py install for psutil 13:08:16 INFO - building 'psutil._psutil_linux' extension 13:08:16 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 13:08:16 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 13:08:16 INFO - building 'psutil._psutil_posix' extension 13:08:16 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 13:08:16 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 13:08:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:16 INFO - Successfully installed psutil 13:08:16 INFO - Cleaning up... 13:08:16 INFO - Return code: 0 13:08:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:08:16 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')]} 13:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:16 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')]} 13:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:16 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 0x7fe03e15df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edf9c0>, '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 0x1ee08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', '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 13:08:16 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 13:08:16 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 13:08:16 INFO - Using env: {'DISPLAY': ':0', 13:08:16 INFO - 'HOME': '/home/cltbld', 13:08:16 INFO - 'LANG': 'en_US.UTF-8', 13:08:16 INFO - 'LANGUAGE': 'en_US:en', 13:08:16 INFO - 'LOGNAME': 'cltbld', 13:08:16 INFO - 'MAIL': '/var/mail/cltbld', 13:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:16 INFO - 'MOZ_NO_REMOTE': '1', 13:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:16 INFO - 'NO_EM_RESTART': '1', 13:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:16 INFO - 'PWD': '/builds/slave/test', 13:08:16 INFO - 'SHELL': '/bin/bash', 13:08:16 INFO - 'SHLVL': '1', 13:08:16 INFO - 'TERM': 'linux', 13:08:16 INFO - 'TMOUT': '86400', 13:08:16 INFO - 'USER': 'cltbld', 13:08:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', 13:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:16 INFO - '_': '/tools/buildbot/bin/python'} 13:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:08:18 INFO - Installing collected packages: mozsystemmonitor 13:08:18 INFO - Running setup.py install for mozsystemmonitor 13:08:18 INFO - Successfully installed mozsystemmonitor 13:08:18 INFO - Cleaning up... 13:08:19 INFO - Return code: 0 13:08:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:19 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 0x7fe03e15df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edf9c0>, '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 0x1ee08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', '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 13:08:19 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 13:08:19 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 13:08:19 INFO - Using env: {'DISPLAY': ':0', 13:08:19 INFO - 'HOME': '/home/cltbld', 13:08:19 INFO - 'LANG': 'en_US.UTF-8', 13:08:19 INFO - 'LANGUAGE': 'en_US:en', 13:08:19 INFO - 'LOGNAME': 'cltbld', 13:08:19 INFO - 'MAIL': '/var/mail/cltbld', 13:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:19 INFO - 'MOZ_NO_REMOTE': '1', 13:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:19 INFO - 'NO_EM_RESTART': '1', 13:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:19 INFO - 'PWD': '/builds/slave/test', 13:08:19 INFO - 'SHELL': '/bin/bash', 13:08:19 INFO - 'SHLVL': '1', 13:08:19 INFO - 'TERM': 'linux', 13:08:19 INFO - 'TMOUT': '86400', 13:08:19 INFO - 'USER': 'cltbld', 13:08:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', 13:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:19 INFO - '_': '/tools/buildbot/bin/python'} 13:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:19 INFO - Downloading/unpacking blobuploader==1.2.4 13:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:21 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:08:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:08:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:21 INFO - Downloading docopt-0.6.1.tar.gz 13:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:08:21 INFO - Installing collected packages: blobuploader, requests, docopt 13:08:21 INFO - Running setup.py install for blobuploader 13:08:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:08:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:08:21 INFO - Running setup.py install for requests 13:08:22 INFO - Running setup.py install for docopt 13:08:22 INFO - Successfully installed blobuploader requests docopt 13:08:22 INFO - Cleaning up... 13:08:22 INFO - Return code: 0 13:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:22 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 0x7fe03e15df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edf9c0>, '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 0x1ee08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', '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 13:08:22 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 13:08:22 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 13:08:22 INFO - Using env: {'DISPLAY': ':0', 13:08:22 INFO - 'HOME': '/home/cltbld', 13:08:22 INFO - 'LANG': 'en_US.UTF-8', 13:08:22 INFO - 'LANGUAGE': 'en_US:en', 13:08:22 INFO - 'LOGNAME': 'cltbld', 13:08:22 INFO - 'MAIL': '/var/mail/cltbld', 13:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:22 INFO - 'MOZ_NO_REMOTE': '1', 13:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:22 INFO - 'NO_EM_RESTART': '1', 13:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:22 INFO - 'PWD': '/builds/slave/test', 13:08:22 INFO - 'SHELL': '/bin/bash', 13:08:22 INFO - 'SHLVL': '1', 13:08:22 INFO - 'TERM': 'linux', 13:08:22 INFO - 'TMOUT': '86400', 13:08:22 INFO - 'USER': 'cltbld', 13:08:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', 13:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:22 INFO - '_': '/tools/buildbot/bin/python'} 13:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:22 INFO - Running setup.py (path:/tmp/pip-MPZe9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:22 INFO - Running setup.py (path:/tmp/pip-IsGDdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:22 INFO - Running setup.py (path:/tmp/pip-ZM5vG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:22 INFO - Running setup.py (path:/tmp/pip-50XAtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:22 INFO - Running setup.py (path:/tmp/pip-Mjvf71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:23 INFO - Running setup.py (path:/tmp/pip-JaozE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:23 INFO - Running setup.py (path:/tmp/pip-u7zHoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:23 INFO - Running setup.py (path:/tmp/pip-5xLSIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:23 INFO - Running setup.py (path:/tmp/pip-giW8_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:23 INFO - Running setup.py (path:/tmp/pip-IPmh2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:23 INFO - Running setup.py (path:/tmp/pip-lG0G92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:23 INFO - Running setup.py (path:/tmp/pip-ztSDeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:23 INFO - Running setup.py (path:/tmp/pip-hQSQxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:23 INFO - Running setup.py (path:/tmp/pip-tuRxwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:23 INFO - Running setup.py (path:/tmp/pip-Cq4pdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:23 INFO - Running setup.py (path:/tmp/pip-2w33wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:23 INFO - Running setup.py (path:/tmp/pip-gqem4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:08:23 INFO - Running setup.py install for manifestparser 13:08:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:08:23 INFO - Running setup.py install for mozcrash 13:08:24 INFO - Running setup.py install for mozdebug 13:08:24 INFO - Running setup.py install for mozdevice 13:08:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:08:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:24 INFO - Running setup.py install for mozfile 13:08:24 INFO - Running setup.py install for mozhttpd 13:08:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:24 INFO - Running setup.py install for mozinfo 13:08:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:24 INFO - Running setup.py install for mozInstall 13:08:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:24 INFO - Running setup.py install for mozleak 13:08:24 INFO - Running setup.py install for mozlog 13:08:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:24 INFO - Running setup.py install for moznetwork 13:08:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:25 INFO - Running setup.py install for mozprocess 13:08:25 INFO - Running setup.py install for mozprofile 13:08:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:25 INFO - Running setup.py install for mozrunner 13:08:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:25 INFO - Running setup.py install for mozscreenshot 13:08:25 INFO - Running setup.py install for moztest 13:08:25 INFO - Running setup.py install for mozversion 13:08:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:25 INFO - Cleaning up... 13:08:25 INFO - Return code: 0 13:08:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:25 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')]} 13:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:25 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')]} 13:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:25 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 0x7fe03e15df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edf9c0>, '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 0x1ee08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', '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 13:08:25 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 13:08:25 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 13:08:25 INFO - Using env: {'DISPLAY': ':0', 13:08:25 INFO - 'HOME': '/home/cltbld', 13:08:25 INFO - 'LANG': 'en_US.UTF-8', 13:08:25 INFO - 'LANGUAGE': 'en_US:en', 13:08:25 INFO - 'LOGNAME': 'cltbld', 13:08:25 INFO - 'MAIL': '/var/mail/cltbld', 13:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:25 INFO - 'MOZ_NO_REMOTE': '1', 13:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:25 INFO - 'NO_EM_RESTART': '1', 13:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:25 INFO - 'PWD': '/builds/slave/test', 13:08:25 INFO - 'SHELL': '/bin/bash', 13:08:25 INFO - 'SHLVL': '1', 13:08:25 INFO - 'TERM': 'linux', 13:08:25 INFO - 'TMOUT': '86400', 13:08:25 INFO - 'USER': 'cltbld', 13:08:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', 13:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:25 INFO - '_': '/tools/buildbot/bin/python'} 13:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:25 INFO - Running setup.py (path:/tmp/pip-N3LORW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:25 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)) 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:25 INFO - Running setup.py (path:/tmp/pip-mRF6rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:26 INFO - Running setup.py (path:/tmp/pip-7_BBJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:26 INFO - Running setup.py (path:/tmp/pip-1tcqyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:26 INFO - Running setup.py (path:/tmp/pip-18WSiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:26 INFO - Running setup.py (path:/tmp/pip-Lr7GEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:26 INFO - Running setup.py (path:/tmp/pip-9H6Rr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:26 INFO - Running setup.py (path:/tmp/pip-9dSCKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:26 INFO - Running setup.py (path:/tmp/pip-saD4Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:26 INFO - Running setup.py (path:/tmp/pip-ghstIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:26 INFO - Running setup.py (path:/tmp/pip-bP4rcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:26 INFO - Running setup.py (path:/tmp/pip-EYf4AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:26 INFO - Running setup.py (path:/tmp/pip-OoyrRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:26 INFO - Running setup.py (path:/tmp/pip-uitd4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:26 INFO - Running setup.py (path:/tmp/pip-YD2dK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:26 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)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:26 INFO - Running setup.py (path:/tmp/pip-CadioQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:27 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)) 13:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:27 INFO - Running setup.py (path:/tmp/pip-fxe92K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:27 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)) 13:08:27 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)) 13:08:27 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)) 13:08:27 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)) 13:08:27 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)) 13:08:27 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)) 13:08:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:28 INFO - Downloading blessings-1.6.tar.gz 13:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:29 INFO - Installing collected packages: blessings 13:08:29 INFO - Running setup.py install for blessings 13:08:29 INFO - Successfully installed blessings 13:08:29 INFO - Cleaning up... 13:08:29 INFO - Return code: 0 13:08:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:29 INFO - Reading from file tmpfile_stdout 13:08:29 INFO - Current package versions: 13:08:29 INFO - argparse == 1.2.1 13:08:29 INFO - blessings == 1.6 13:08:29 INFO - blobuploader == 1.2.4 13:08:29 INFO - docopt == 0.6.1 13:08:29 INFO - manifestparser == 1.1 13:08:29 INFO - mozInstall == 1.12 13:08:29 INFO - mozcrash == 0.17 13:08:29 INFO - mozdebug == 0.1 13:08:29 INFO - mozdevice == 0.48 13:08:29 INFO - mozfile == 1.2 13:08:29 INFO - mozhttpd == 0.7 13:08:29 INFO - mozinfo == 0.9 13:08:29 INFO - mozleak == 0.1 13:08:29 INFO - mozlog == 3.2 13:08:29 INFO - moznetwork == 0.27 13:08:29 INFO - mozprocess == 0.22 13:08:29 INFO - mozprofile == 0.28 13:08:29 INFO - mozrunner == 6.11 13:08:29 INFO - mozscreenshot == 0.1 13:08:29 INFO - mozsystemmonitor == 0.3 13:08:29 INFO - moztest == 0.7 13:08:29 INFO - mozversion == 1.4 13:08:29 INFO - psutil == 3.1.1 13:08:29 INFO - requests == 1.2.3 13:08:29 INFO - wsgiref == 0.1.2 13:08:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:29 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 0x7fe03e15df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edf9c0>, '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 0x1ee08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', '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 13:08:29 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 13:08:29 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 13:08:29 INFO - Using env: {'DISPLAY': ':0', 13:08:29 INFO - 'HOME': '/home/cltbld', 13:08:29 INFO - 'LANG': 'en_US.UTF-8', 13:08:29 INFO - 'LANGUAGE': 'en_US:en', 13:08:29 INFO - 'LOGNAME': 'cltbld', 13:08:29 INFO - 'MAIL': '/var/mail/cltbld', 13:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:29 INFO - 'MOZ_NO_REMOTE': '1', 13:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:29 INFO - 'NO_EM_RESTART': '1', 13:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:29 INFO - 'PWD': '/builds/slave/test', 13:08:29 INFO - 'SHELL': '/bin/bash', 13:08:29 INFO - 'SHLVL': '1', 13:08:29 INFO - 'TERM': 'linux', 13:08:29 INFO - 'TMOUT': '86400', 13:08:29 INFO - 'USER': 'cltbld', 13:08:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', 13:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:29 INFO - '_': '/tools/buildbot/bin/python'} 13:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:29 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)) 13:08:29 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)) 13:08:29 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)) 13:08:29 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)) 13:08:29 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)) 13:08:29 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)) 13:08:29 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)) 13:08:29 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)) 13:08:29 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)) 13:08:29 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)) 13:08:29 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)) 13:08:29 INFO - Cleaning up... 13:08:29 INFO - Return code: 0 13:08:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:29 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 0x7fe03e15df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edf9c0>, '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 0x1ee08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', '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 13:08:29 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 13:08:29 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 13:08:29 INFO - Using env: {'DISPLAY': ':0', 13:08:29 INFO - 'HOME': '/home/cltbld', 13:08:29 INFO - 'LANG': 'en_US.UTF-8', 13:08:29 INFO - 'LANGUAGE': 'en_US:en', 13:08:29 INFO - 'LOGNAME': 'cltbld', 13:08:29 INFO - 'MAIL': '/var/mail/cltbld', 13:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:29 INFO - 'MOZ_NO_REMOTE': '1', 13:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:29 INFO - 'NO_EM_RESTART': '1', 13:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:29 INFO - 'PWD': '/builds/slave/test', 13:08:29 INFO - 'SHELL': '/bin/bash', 13:08:29 INFO - 'SHLVL': '1', 13:08:29 INFO - 'TERM': 'linux', 13:08:29 INFO - 'TMOUT': '86400', 13:08:29 INFO - 'USER': 'cltbld', 13:08:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', 13:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:29 INFO - '_': '/tools/buildbot/bin/python'} 13:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:29 INFO - Downloading/unpacking jsonschema 13:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:08:31 INFO - Downloading/unpacking functools32 (from jsonschema) 13:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:08:32 INFO - warning: no files found matching '*.txt' 13:08:32 INFO - no previously-included directories found matching 'build' 13:08:32 INFO - no previously-included directories found matching 'dist' 13:08:32 INFO - no previously-included directories found matching '.git*' 13:08:32 INFO - Installing collected packages: jsonschema, functools32 13:08:32 INFO - Running setup.py install for functools32 13:08:32 INFO - warning: no files found matching '*.txt' 13:08:32 INFO - no previously-included directories found matching 'build' 13:08:32 INFO - no previously-included directories found matching 'dist' 13:08:32 INFO - no previously-included directories found matching '.git*' 13:08:32 INFO - Successfully installed jsonschema functools32 13:08:32 INFO - Cleaning up... 13:08:32 INFO - Return code: 0 13:08:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:32 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 0x7fe03e15df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e50770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edf9c0>, '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 0x1ee08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', '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 13:08:32 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 13:08:32 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 13:08:32 INFO - Using env: {'DISPLAY': ':0', 13:08:32 INFO - 'HOME': '/home/cltbld', 13:08:32 INFO - 'LANG': 'en_US.UTF-8', 13:08:32 INFO - 'LANGUAGE': 'en_US:en', 13:08:32 INFO - 'LOGNAME': 'cltbld', 13:08:32 INFO - 'MAIL': '/var/mail/cltbld', 13:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:32 INFO - 'MOZ_NO_REMOTE': '1', 13:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:32 INFO - 'NO_EM_RESTART': '1', 13:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:32 INFO - 'PWD': '/builds/slave/test', 13:08:32 INFO - 'SHELL': '/bin/bash', 13:08:32 INFO - 'SHLVL': '1', 13:08:32 INFO - 'TERM': 'linux', 13:08:32 INFO - 'TMOUT': '86400', 13:08:32 INFO - 'USER': 'cltbld', 13:08:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', 13:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:32 INFO - '_': '/tools/buildbot/bin/python'} 13:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:32 INFO - Downloading/unpacking flake8 13:08:32 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 13:08:32 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 13:08:32 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 13:08:32 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 13:08:32 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 13:08:32 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 13:08:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:08:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:08:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:34 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 13:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:08:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:08:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:08:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:08:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:08:35 INFO - no previously-included directories found matching 'docs/_build' 13:08:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:08:35 INFO - Running setup.py install for pep8 13:08:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:08:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:08:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:08:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:08:35 INFO - no previously-included directories found matching 'docs/_build' 13:08:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:08:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:08:35 INFO - Cleaning up... 13:08:35 INFO - Return code: 0 13:08:35 INFO - Running post-action listener: _resource_record_post_action 13:08:35 INFO - Running post-action listener: _start_resource_monitoring 13:08:35 INFO - Starting resource monitoring. 13:08:35 INFO - ##### 13:08:35 INFO - ##### Finished create-virtualenv step (success) 13:08:35 INFO - ##### 13:08:35 INFO - ##### 13:08:35 INFO - ##### Running install step. 13:08:35 INFO - ##### 13:08:35 INFO - Running pre-action listener: _resource_record_pre_action 13:08:35 INFO - Running main action method: install 13:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:35 INFO - Reading from file tmpfile_stdout 13:08:35 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:35 INFO - Reading from file tmpfile_stdout 13:08:35 INFO - Output received: 13:08:35 INFO - Usage: mozinstall [options] installer 13:08:35 INFO - Options: 13:08:35 INFO - -h, --help show this help message and exit 13:08:35 INFO - -d DEST, --destination=DEST 13:08:35 INFO - Directory to install application into. [default: 13:08:35 INFO - "/builds/slave/test"] 13:08:35 INFO - --app=APP Application being installed. [default: firefox] 13:08:35 INFO - mkdir: /builds/slave/test/build/application 13:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:08:51 INFO - Reading from file tmpfile_stdout 13:08:51 INFO - Output received: 13:08:51 INFO - /builds/slave/test/build/application/firefox/firefox 13:08:51 INFO - Running post-action listener: _resource_record_post_action 13:08:51 INFO - ##### 13:08:51 INFO - ##### Finished install step (success) 13:08:51 INFO - ##### 13:08:51 INFO - ##### 13:08:51 INFO - ##### Running run-tests step. 13:08:51 INFO - ##### 13:08:51 INFO - Running pre-action listener: _resource_record_pre_action 13:08:51 INFO - Running main action method: run_tests 13:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:51 INFO - Python 2.7.3 13:08:51 INFO - Return code: 0 13:08:51 INFO - grabbing minidump binary from tooltool 13:08:51 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')]} 13:08:51 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 0x1edf9c0>, '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 0x1ee08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:51 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 13:08:51 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 13:08:51 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 13:08:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:51 INFO - Return code: 0 13:08:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:08:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:08:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:08:52 INFO - Return code: 0 13:08:52 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/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 13:08:52 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/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 13:08:52 INFO - Using env: {'DISPLAY': ':0', 13:08:52 INFO - 'HOME': '/home/cltbld', 13:08:52 INFO - 'LANG': 'en_US.UTF-8', 13:08:52 INFO - 'LANGUAGE': 'en_US:en', 13:08:52 INFO - 'LOGNAME': 'cltbld', 13:08:52 INFO - 'MAIL': '/var/mail/cltbld', 13:08:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:52 INFO - 'MOZ_NO_REMOTE': '1', 13:08:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:52 INFO - 'NO_EM_RESTART': '1', 13:08:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:52 INFO - 'PWD': '/builds/slave/test', 13:08:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:52 INFO - 'SHELL': '/bin/bash', 13:08:52 INFO - 'SHLVL': '1', 13:08:52 INFO - 'TERM': 'linux', 13:08:52 INFO - 'TMOUT': '86400', 13:08:52 INFO - 'USER': 'cltbld', 13:08:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135', 13:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:52 INFO - '_': '/tools/buildbot/bin/python'} 13:08:52 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/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 13:08:52 INFO - mozversion application_buildid: 20160526123752 13:08:52 INFO - mozversion application_changeset: 6a6155e3afa6148ef93255e6d9e126c2974f0319 13:08:52 INFO - mozversion application_display_name: Nightly 13:08:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:52 INFO - mozversion application_name: Firefox 13:08:52 INFO - mozversion application_remotingname: firefox 13:08:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:08:52 INFO - mozversion application_vendor: Mozilla 13:08:52 INFO - mozversion application_version: 49.0a1 13:08:52 INFO - mozversion platform_buildid: 20160526123752 13:08:52 INFO - mozversion platform_changeset: 6a6155e3afa6148ef93255e6d9e126c2974f0319 13:08:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:08:52 INFO - mozversion platform_version: 49.0a1 13:08:52 INFO - using testdate: 1464293332 13:08:52 INFO - actual date: 1464293332 13:08:52 INFO - starting webserver on 'localhost:45510' 13:08:52 INFO - SUITE-START | Running 2 tests 13:08:52 INFO - TEST-START | dromaeo_css 13:08:52 INFO - operating with platform_type : linux_ 13:08:52 INFO - Initialising browser for dromaeo_css test... 13:08:52 INFO - TEST-INFO | started process 26690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTPxwLI/profile http://localhost:45510/getInfo.html) 13:08:57 INFO - PROCESS | 26690 | __metrics Screen width/height:1600/1200 13:08:57 INFO - PROCESS | 26690 | colorDepth:24 13:08:57 INFO - PROCESS | 26690 | Browser inner width/height: 1024/697 13:08:57 INFO - PROCESS | 26690 | __metrics 13:08:58 ERROR - PROCESS | 26690 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:08:59 INFO - TEST-INFO | 26690: exit 0 13:08:59 INFO - Browser initialized. 13:08:59 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:59 INFO - TEST-INFO | started process 26770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTPxwLI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:11 INFO - PROCESS | 26770 | RSS: Main: 156848128 13:09:11 INFO - PROCESS | 26770 | 13:10:02 INFO - PROCESS | 26770 | 1464293402748 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] 13:12:14 INFO - PROCESS | 26770 | Cycle 1(1): loaded http://localhost:45510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45510/tests/dromaeo/cssquery-ext.html) 13:12:15 INFO - PROCESS | 26770 | RSS: Main: 271499264 13:12:15 INFO - PROCESS | 26770 | 13:15:18 INFO - PROCESS | 26770 | Cycle 1(1): loaded http://localhost:45510/tests/dromaeo/cssquery-ext.html (next: http://localhost:45510/tests/dromaeo/cssquery-jquery.html) 13:15:19 INFO - PROCESS | 26770 | RSS: Main: 239902720 13:15:19 INFO - PROCESS | 26770 | 13:18:21 INFO - PROCESS | 26770 | Cycle 1(1): loaded http://localhost:45510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45510/tests/dromaeo/cssquery-mootools.html) 13:18:21 INFO - PROCESS | 26770 | RSS: Main: 237944832 13:18:21 INFO - PROCESS | 26770 | 13:21:24 INFO - PROCESS | 26770 | Cycle 1(1): loaded http://localhost:45510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45510/tests/dromaeo/cssquery-prototype.html) 13:21:24 INFO - PROCESS | 26770 | RSS: Main: 234979328 13:21:24 INFO - PROCESS | 26770 | 13:24:27 INFO - PROCESS | 26770 | Cycle 1(1): loaded http://localhost:45510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45510/tests/dromaeo/cssquery-yui.html) 13:24:28 INFO - PROCESS | 26770 | RSS: Main: 227201024 13:24:28 INFO - PROCESS | 26770 | 13:27:30 INFO - PROCESS | 26770 | Cycle 1(1): loaded http://localhost:45510/tests/dromaeo/cssquery-yui.html (next: http://localhost:45510/tests/dromaeo/cssquery-dojo.html) 13:27:31 INFO - PROCESS | 26770 | RSS: Main: 270426112 13:27:31 INFO - PROCESS | 26770 | 13:27:31 INFO - PROCESS | 26770 | __start_tp_report 13:27:31 INFO - PROCESS | 26770 | _x_x_mozilla_page_load 13:27:31 INFO - PROCESS | 26770 | _x_x_mozilla_page_load_details 13:27:31 INFO - PROCESS | 26770 | |i|pagename|runs| 13:27:31 INFO - PROCESS | 26770 | |0;dojo.html;2659.494696007758;2678.9464210715773;2700.7839372850176;2707.837529748215;2713.9144342263094;4681.742504162274;4739.620830333573;4765.8808529786775;4804.20730579454;4843.079814835179;4750.714957102577;4808.615310775138;4815.205491093974;4834.371531700874;4883.706977581339;4363.847265345714;4370.125974805036;4399.802008909607;4428.424304840374;4495.842645507408;4426.955730442703;4469.463664360282;4546.136234115507;4583.908321833561;4601.493835678073;4356.43366362374;4498.460184777815;4527.569880861313;4551.340055691906;4556.8860778480475;4391.3193455014525;4408.889777755549;4409.625181859546;4416.183006143874;4447.533009034038;4378.868633940955;4437.201303765353;4447.644188464915;4464.6874718769695;4500.819967201308;4669.836555720567;4812.230043193107;4830.396200474941;4832.081904438181;4849.054434385296;5090.847274581768;5153;5157.948420515784;5215.6349055566125;5219.530242278175;5220.347456567929;5222.73886305687;5240.973795131038;5247.23915032322;5251.579873610102;4728.219843725747;4797.664163508521;4850.490698476609;4899.387576552931;4908.779104940286;5295.364556253275;5305.4164041955355;5352.090144675414;5356.1697936819855;5362.195670649356;5118.718470484085;5128.358955130609;5161.767720452589;5167.612429067835;5175.146100893386;4925.408950925912;5149.845504634867;5213.687178769286;5256.684598924076;5271.209318602164;5175.301334319894;5184.688918664892;5190.714510701948;5192.844214673566;5224.111900976843;5142.537171654569;5165.302684137593;5166.844994650167;5172.586193104543;5219.608529360313;4364.170807546556;4406.977965110218;4411.889702757457;4418.469783625986;4487.439070116236;3870.4194370844034;3875.8643447479767;3895.5130608673917;3928.017995501125;3975.960240397617;4483.30508771141;4485.842995495207;4492.797824097924;4537.478190008192;4541.977290113595;5061.569766569883;5178.197379406198;5229.424763276036;5247.134222853263;5265.868353291198;4480.977595112004;4498.437695288089;4507.864764057083;4542.84100056503;4547.363369128325;4747.928781068286;4752.287156926489;4752.596029337545;4755.95486007815;4807.759612019385;4764.28535719631;4817.638677099161;4848.5636292733825;4859.00390419956;4916.410030796327;5189.221616757516;5209.6092793041435;5214.348206474191;5214.504622060898;5254.97372513135;4844.370231869834;4874.390701162355;4874.463808981081;4887.951120488749;4922.556969872729;4943.382077240345;5101.336826212569;5108.131617625087;5122.231665250242;5179.974100129475;5249.527542521038;5264.657797243167;5268.683878967274;5279.498447647467;5285.101532739367;5118.283440318284;5121.7695203715175;5124.231365295235;5138;5159.638825282194;4910.729909854849;4970.353853999101;5007.048660754445;5038.672486288379;5065.366829146356;4959.057779021974;4973.801047958041;4981.252812078217;5004.3494345734825;5023.648344615842;4889.975550122226;5078.4667609900425;5082.136036873814;5121.07820592297;5130.7178105204575;4923.581495572773;5009.398872135367;5019.64862459639;5034.993001399662;5037.571806396498 13:27:31 INFO - PROCESS | 26770 | |1;ext.html;547.2282887176451;598.2163365990551;598.5092224376011;598.9670568118752;599.9370066143052;39226.21547569051;40411.59588404115;40417.39373909394;40557.3916391254;44964;42227.78886105573;42642.786786066026;42701.14597708044;42751.78624106883;42818.57181428185;7766.184550622174;7934.44458887878;7951.085625153123;7951.324137448295;7952.840943181133;7829.882551761728;7929.762107136795;7930.048394192676;7931.801704957394;7934.920650793476;7896.960515197416;7925;7928.524288542677;7939.325157361603;7943.761687149395;7828.256315650033;7897.763067107996;7899.644515996794;7901.802454938673;7904.565248911307;7837.568933708644;7862.331701805296;7904.762857114296;7918;7918.683252669886;39170.216595668215;39565.60434395648;39600.80199598984;39639;39657;3034.575159477675;3130.8904188353526;3200.391925534141;3210.4702724050503;3684.6315368463206;29893.40213195724;30027.099187024425;30033.249168770737;30098.24754381136;30350.392992140034;3370.5955285365667;3383.644717304672;3417.709494692954;3459.9481007784902;3558.9110272243142;254591;254698;255158;255201;255796;45207.321890171675;50056.499435005186;51239.743801280754;51566;52692.736536317076;46325.30512042322;47526.76236618864;49626.503734962185;49630.25554616684;50885;12986;13120.278384688743;13145.014123940742;13157.473701052042;13160.210387376788;9810.607575697035;9862.457564834003;9893.703188904345;9904.356216845881;10066.69799906004;16624.418145364853;16662.500124996026;16674.58313542171;16686.499405017625;16690.66618667644;6295.811125666238;6386.457151142112;6449.809022143427;6579.2104947406615;6702.329767023356;848.3976376772438;861.9913800862037;862.9266512346395;870.4516154822421;987.8468837330082;26620.334491637477;27858.442831143264;27897.891897292193;27923.72076279252;28224.85887570549;927.4157280912982;956.1490273656451;965.9275554333453;966.9613215471443;1033.4109557552124;14516.491922782652;14608.707825843636;14679;14858.628534286514;15140.242987850563;112365;350597;350727;351497;352311;49852;50051.24923126156;50095.499045009085;50096.99999999927;50143;1066.3015724700178;1149.7298134938283;1188.9702757431132;1191.624638238952;1212.8847759463013;28101.156965291073;28633.14100576986;28924.710752892202;29357.85321073381;29444.558331624616;42419.5758042428;42580.574194257664;42809.1438171241;42930.78534607307;42974;290650;291663;291830;293148;293536;31645.36709265848;36221;36572.63427365692;37532.624673752915;37555.62444375631;41904.3714344279;42361.78819105885;42611.57388426076;42959.1408171841;43785.56214437942;36298.27403451863;36357.63642363543;36669.449958250116;36988.63011369852;37295;36282.4557631641;36386.09034774152;36518.26963460663;36611;36754.8162259187;35826.95470885004;36939;37217.4417383734;39013.609863900994;39711.40432893567;31364.529532057495;33478.33043339168;33609.495857562644;33645.83177084099;33878;24936.501269974862;25415.74584254134;25576.872115639304;25643.743562564883;25911.481770364866 13:27:31 INFO - PROCESS | 26770 | |2;jquery.html;350.264444666201;350.5092869982026;354.58159371941133;361.0414349901014;378.38701303887706;15993.360265589377;17260.568485787844;17352.392666256685;17737.46787596371;17767.55581110473;16445.83554164458;16694.998300102;17388.21753021114;17442.651146977052;17451.91274043628;4949.50504949504;5080.466551012146;5133.460986596409;5133.563647090002;5133.666311689728;3725.329440700673;3891.824867880938;5091.541761241488;5591.9720401398135;5939.88120237595;5959.433853783884;5975.372585878486;5981.760729570812;5982.042873140276;5992.9700351498395;5866.882662346729;5868.2371291732015;5970.8805823883495;5981.102834574827;6037;3375.763696541243;4798.304245884327;5125.794968201268;5125.794968201268;5262;19606.215751369928;20075.89962050195;20257.696134557995;20543.38369848907;20635;1789.2485156234284;1987.960240795176;2270.1713874435713;2289.004283136841;2514.7233804281514;9179.954100229523;9192.35653504255;9220.308476864195;9539.713808585753;11026.393548354838;1721.8794684372099;1801.3737949601057;1807.2590238002356;1835.8898466091944;1903.077007651288;65080;66085;66926;67088.6645566774;67737.66131169412;9646.601242819752;9724.319297649097;9732;9847.60609575609;10078.244131690153;13891.305434728223;13940.302984850718;13973;13973.09174903628;14101.929490352482;6709.261981182066;6900.965495172492;6932.064171336805;7058.364747172779;7139.464540159509;6424.967875160594;6461.418472337512;6590.3080176581725;6612.140421745238;6632.668366581652;4008.9599104008585;4079.204555111725;4100.134438830325;4118.711690181659;4162.729422587522;1610.492694801134;1660.96678066438;1748.5685835200397;1804.9097545122954;1839.981600183981;767.5897681280783;803.9799005024921;821.5235163605095;840.6259214649544;912.5619702542684;15731.764023539656;16530.173491325386;16533;16533.50399488017;17175.31298748036;834.8872902158131;837.3008537870946;847.872819077131;850.9361797865184;867.418829384314;9247.491387973592;9267.119623635745;9423.246140308758;9485.241180705527;9778.364406313567;355343;364859.6374613325;368702;369235;382294;69336.30663693299;69818.65090674616;71077.64461177662;71147;71550.64224678843;904.0507467159456;908.9136532029447;914.7118657622827;915.3958387464374;920.1488623023677;14682.80117414504;14687.265636718335;14687.632809179857;14928.253587320807;15306;32622.34755304928;32661.836690817345;33258.50112248366;33524.49713254254;33992.320153596294;46196.76901615471;46244.306335404326;46466.30300545427;46565.3015204779;46571.06857862892;4753.952460475351;4898;6732.495062870206;7181.461390395637;7414.702427075348;8053.919460805317;10434.269601127848;10993;11070.889291106985;11314.434278285888;8527.53098579584;8805.207531322212;8907.866382004404;9193.448393096436;9569.473678947446;9643.469609171283;9914.553845076845;10162.339447935861;10255.435951022468;10350.844737328796;5054.924176137434;5155;9552.90447095548;9835.459049752333;9910.15763660097;7424.480286379901;7462.10454745434;7487.625618719151;7523.3981281498445;7686.538807671334;7937.920620793718;9393.953030234805;9470.668526601536;9494.430334179971;9864.408135511892 13:27:31 INFO - PROCESS | 26770 | |3;mootools.html;1216.4586758892285;1389.3608939887654;1449.2101804516537;1517.5750789778858;1771.1232939694844;6904.240533541312;7820.3743700503965;8064.758057258277;8067.838643227139;8326.333893288538;8008.479448835822;8152.429329946906;8164.469309494879;8166.67333306667;8174.6730130794695;1877.1271358818146;2114.756802967663;2132.552164045552;2194.1552502286654;2256.5825322315422;2284.8400611957086;2295.6097463431174;2301.2060839010596;2303.6429353450158;2306.8615883046987;2194.1333173396497;2219.2343641443676;2229.9888500557477;2236.206146817881;2237.429455488856;1803.8196180381922;2059.4542446251753;2119.1417475922276;2128.8935553222277;2129.9041543130443;2165.07984106754;2194.561087782434;2195.1877805212175;2196.6595177747477;2197.48359135603;8104.230098140667;8176.632051557634;8181.3863960202625;8185.3451723861945;8187.467814592092;4626.352310676508;4731.69243999139;4743.525647435264;4748.216544270226;4750.786214620351;2827.915162545127;2840.630718006646;2980.314527658629;2995.925101872449;3015.6531998820196;905.226031742857;927.6039560461462;927.9628814847398;935.0696057422907;936.9109934556207;11319.830202546967;11329.263597866195;11338.263012904217;11347.262427942158;11359.261647992855;4238.470191226097;4279.165562715303;4366;4404.713693609905;4405.493368262691;9541.379810312308;9563.856542151872;9567.330286879851;9568.76078098053;9574.712758617252;4527.320901864747;4582.083583283356;4582.450105987236;4586.816527338936;4590.747508886977;3534.9469757953652;4136.627703506699;4243.2998555238655;4262.488501379792;4302.612764851178;3722.181120153562;3728.571214310389;3775.9433608495897;3851.9037024074623;3856.807159642007;1200.5797970710182;1212.0848759186758;1223.3577371879655;1225.6874497003207;1233.9876601233873;774.883767434878;794.4359504751576;796.5857753967904;798.4650284309527;819.9098099209082;4744.596709279681;4878.853634390974;4947.876303092451;4974.369468971332;5025.47232540578;395.4483495523786;396.61528317531946;397.31264911702914;398.2055798681591;873.1792115411492;3310.3213841162506;3434;3446.724262059029;3459.9135021624156;3471.3751524725285;9720.270979676552;9996.400215986918;10025.94727553611;10039;10147.289689721796;9951.15415189717;10011.79976400468;10024.147947424404;10037.146842518321;10044;7245.166805817398;7473.215312392121;7493.100827900686;7716;7726.420518461138;5018.573421259088;5218.582513398843;5235.554977826928;5303.443138470405;5333.173358129496;9157.130072643089;9214.078592141;9292;9378.296627752808;9405.95297023538;9237.491937943478;9470.100340467645;9484.668036618685;9652.662156824477;9661.661841835503;5951.851203719942;6656.167979002625;6698.698558564779;6780.118584583973;6850.965745171242;7667.194944530744;7680.385569154566;7744.6902123914415;7745.806354841174;7753.069631644239;6873.450123989969;7051.576905385693;7075.929240707733;7176;7195.71217151329;6961.477889158435;6988.860222795617;7044.189918159477;7066.258042905421;7076.716931322895;6505.7072431741635;6575.375339342755;6688.632125232964;6693;6697.162854643169;4458.7324760514475;4470.441194850644;4499;4515.051839113691;4530.161920044802;4410.470743510799;4542.954570454253;4569.086182763527;4587.151376995266;4608.078384323216 13:27:31 INFO - PROCESS | 26770 | |4;prototype.html;297.5165356296019;305.60424250595474;312.362779928945;313.78662509493535;317.4793338924165;4624.468186158593;4810.639202059842;4885.63357748169;4888.486708895563;4927.802887884485;4645.374119058336;4799.280107983805;4817.108834865552;4819.1325561398935;4845;3825.7895815730126;3828.3300422426105;3851.903702407434;3857.1514266861245;3859.903502412434;3594.4967704521387;3692.4461330800327;3837.827297771607;3850.3646898261754;3871.2838124946834;3805.771653700773;3806.2768074065975;3806.9619303806885;3811.752236104658;3817.0075780297184;3782.6595606395417;3784.4701741756176;3786.810659467043;3794.330494582389;3805.1248212911187;3333.1500467380906;3351.0784534253276;3353.782004169721;3368.4947257911263;3389.4407422775457;4568.771561421916;4673.439187297546;4675.672702910798;4679.672422930396;4682.719036857799;4323.308270676676;4326.502452217972;4328.783560821947;4329.5453977332245;4350.782460876943;4917.950820491785;5092.9745351273;5106.208537676666;5110.718910459923;5120.49095942989;3606.2607165531003;3617.276544691072;3619;3624.676992897573;3625.2386998730035;5213.635045546814;5268.683878967236;5312.787488500456;5329.626926115174;5345.30511033567;3571.357295387872;3675.5221821163077;3693.612170722089;3705.1478160023344;3705.9073523161596;3678.7240956928335;3768.3970564709516;3782.6973842092566;3782.9432558511644;3783.2622638585763;4242.151569686075;4244.639205667553;4252.596003379674;4293.355996600472;4297.333913243452;5038.916632923939;5082.313887625123;5087.186050231945;5098.337216161875;5107.41264754558;1178.7996040673106;1226.920250183753;1232.3160645841645;1283.8972882169592;1297.8053292006086;820.5158956215861;821.8356328734277;836.4646626159263;836.9120143813019;837.9512092932843;4025.335819589735;4065.6137666921595;4069.877903662895;4102.2000709861295;4117.711760176819;4600.631949444037;4604.194266003503;4662.790174442158;4672.5327467253;4674.205385084544;4073.327900896378;4078.3882417636996;4095.5904409558807;4098.323776576891;4106.425100485934;2404.3388068281015;2465.963010554843;2493.8254322197636;2504.4114633061217;2509.7992160627105;4397.2964325707735;4406.294992801137;4408.6854401439505;4424.911501770011;4432.3794668746405;4682.695624784378;4714.750591093363;4721.268203428405;4726.26742854858;4758.500357462486;4223.429836972031;4385.780710964439;4408.713433626804;4436.223660859401;4458.977705111453;4578.198815207392;4611.608013318905;4630.536946305478;4659.767011649472;4683.391159149289;4498.8875278117;4526.275795872644;4583.74789386587;4588.4952655207235;4601.492186758158;4057.776822274803;4364.410804541346;4416.492103408149;4429.357743127164;4442.333649952533;3280.803151810899;3286.326303107905;3290.6709329066903;3296.587926509186;3308.669133086672;4957.330760347451;5061.924071138862;5238.790448382022;5270.868228294324;5276;5036.798528058836;5039.899202015866;5040.832442049954;5050.888804463012;5080.339555857862;4870.878228044327;5030.622703297194;5055.51972562606;5076.796928122833;5093.592512599057;5026.874328141826;5082.161443361952;5091.643584949018;5092.134337162765;5093.548338723446;5025.221090730943;5070;5105.897882042413;5128.333316668809;5130;4848.296996935354;4953.23224900141;4975.502449754996;5012.598992080698;5016.824411145592 13:27:31 INFO - PROCESS | 26770 | |5;yui.html;724.5145752345928;743.9404847612192;755.4485225785177;758.3932853717032;761.8666733321671;11756.294622322655;12517.24896506208;12592.622221333364;12593.433295501702;12610.117291789578;10535.683929482127;11593;11610.767784644302;11707.356095414749;11710.765784684301;757.9431542634297;779.5050143159107;780.683823051665;791.4064451661254;791.70311133325;784.231453175888;789.2462698123278;790.7746292306693;791.5211297165218;792.7740593930731;664.1134085995202;801.3629164813958;839.471133186092;840.0213750980101;840.306746933779;806.1776987472745;808.6441965535146;809.348474478045;809.9838003239902;813.4549851599413;596.0314488955447;596.6062398816804;597.2772944736873;597.2981746447906;597.9491743201833;12723.23660580368;12730;12758.553450629184;12760.425780839885;12778.297193654345;12211.93894030533;12664.936675316565;12690.238585684796;12737.235765854079;12953.611391658265;10645.361278323247;11015.504302306415;11175.050120739746;11178.888211117948;11260.21178517504;4087.7956102195067;4141.233871733739;4155.065110350177;4188.141431006637;4266.637335826458;45762.08475830465;45888.77055614734;45903.77048114738;45911.31133033007;45954.31068533975;9779.168770654574;9991.150752186;10188.694339169837;10300.330478518872;10641.89358106409;16150.353985840435;16187.514374568782;16292.42976495817;16318.918405407898;16355.91822040906;6626.933730662631;6673.265940746514;6693.665316734144;6802.319768023158;6854.417374523221;3501.352249833789;3503.7722548034294;3534.3638145134123;3627.9093022674115;3711.573169085536;2748.8625568721486;2799.3701417180973;2835.3762172322467;2836.971630283712;2842.8862845486365;533.4079172118945;558.3969313141797;567.492094575361;572.7880684146892;577.0305886111289;407.94492743479844;480.8485327121945;496.48117716985837;524.593440083938;535.0796629796744;7094.396976257076;7208.639568021578;7216.530925489827;7273.563586184846;7417.554946703215;446.74312270444625;482.35364611420863;495.8016793282716;507.28979428799977;528.0626887275041;3511.543499345069;3524.8413821377585;3539.752217344761;3584.6594573515476;3603.0992251937014;41254.38118428226;41289.79355103205;41372;45835.54164458313;46560;47298.763506182935;48987.51012489901;49282.26076608854;49637;49954;45098;45809;45848;46455.535444645124;46520.53479465162;7753.185915479019;7761.7671469855995;7843.882341764992;8028.197180281925;8279.710210142615;29968.25079373033;30436.543451847796;31205.68794312028;31743;31803.840980795874;39412;39941.600583993786;40120.1975960485;40136.39795403013;41266.79366603148;9910.801783964136;10423.061924426838;10623.150147988297;10818.567257309935;10849.945750271514;8345.332373410234;10707.250492465453;11110.833337500106;11448.255863368855;11929.701757456132;10454.843177352193;10514.94742526313;10581.735456613646;10727.570897164338;10752.247342685936;10582.629607963685;10736.30214036085;10742;10899.29154604948;11540.422978850856;10182.592696292066;10619.30974486656;10702.83945740799;10718.785624287626;10930.56277748881;9584.808303834025;9848.950755246178;9963.003699629979;9996.750081248027;10050.597976080875;8790.648374064966;8878.422902511316;9119.452832830051;9153.17621414076;9264.861027084735 13:27:31 INFO - PROCESS | 26770 | __end_tp_report 13:27:31 INFO - PROCESS | 26770 | __start_cc_report 13:27:31 INFO - PROCESS | 26770 | _x_x_mozilla_cycle_collect,1051 13:27:31 INFO - PROCESS | 26770 | __end_cc_report 13:27:31 INFO - PROCESS | 26770 | __startTimestamp1464294451072__endTimestamp 13:27:31 INFO - PROCESS | 26770 | 13:27:31 INFO - PROCESS | 26770 | ------- Summary: start ------- 13:27:31 INFO - PROCESS | 26770 | Number of tests: 6 13:27:31 INFO - PROCESS | 26770 | 13:27:31 INFO - PROCESS | 26770 | [#0] dojo.html Cycles:165 Average:4800.67 Median:4899.39 stddev:503.81 (10.3%) stddev-sans-first:476.53 13:27:31 INFO - PROCESS | 26770 | Values: 2659.5 2678.9 2700.8 2707.8 2713.9 4681.7 4739.6 4765.9 4804.2 4843.1 4750.7 4808.6 4815.2 4834.4 4883.7 4363.8 4370.1 4399.8 4428.4 4495.8 4427.0 4469.5 4546.1 4583.9 4601.5 4356.4 4498.5 4527.6 4551.3 4556.9 4391.3 4408.9 4409.6 4416.2 4447.5 4378.9 4437.2 4447.6 4464.7 4500.8 4669.8 4812.2 4830.4 4832.1 4849.1 5090.8 5153.0 5157.9 5215.6 5219.5 5220.3 5222.7 5241.0 5247.2 5251.6 4728.2 4797.7 4850.5 4899.4 4908.8 5295.4 5305.4 5352.1 5356.2 5362.2 5118.7 5128.4 5161.8 5167.6 5175.1 4925.4 5149.8 5213.7 5256.7 5271.2 5175.3 5184.7 5190.7 5192.8 5224.1 5142.5 5165.3 5166.8 5172.6 5219.6 4364.2 4407.0 4411.9 4418.5 4487.4 3870.4 3875.9 3895.5 3928.0 3976.0 4483.3 4485.8 4492.8 4537.5 4542.0 5061.6 5178.2 5229.4 5247.1 5265.9 4481.0 4498.4 4507.9 4542.8 4547.4 4747.9 4752.3 4752.6 4756.0 4807.8 4764.3 4817.6 4848.6 4859.0 4916.4 5189.2 5209.6 5214.3 5214.5 5255.0 4844.4 4874.4 4874.5 4888.0 4922.6 4943.4 5101.3 5108.1 5122.2 5180.0 5249.5 5264.7 5268.7 5279.5 5285.1 5118.3 5121.8 5124.2 5138.0 5159.6 4910.7 4970.4 5007.0 5038.7 5065.4 4959.1 4973.8 4981.3 5004.3 5023.6 4890.0 5078.5 5082.1 5121.1 5130.7 4923.6 5009.4 5019.6 5035.0 5037.6 13:27:31 INFO - PROCESS | 26770 | 13:27:31 INFO - PROCESS | 26770 | [#1] ext.html Cycles:180 Average:44763.69 Median:39091.91 stddev:75946.17 (194.3%) stddev-sans-first:76086.65 13:27:31 INFO - PROCESS | 26770 | Values: 547.2 598.2 598.5 599.0 599.9 39226.2 40411.6 40417.4 40557.4 44964.0 42227.8 42642.8 42701.1 42751.8 42818.6 7766.2 7934.4 7951.1 7951.3 7952.8 7829.9 7929.8 7930.0 7931.8 7934.9 7897.0 7925.0 7928.5 7939.3 7943.8 7828.3 7897.8 7899.6 7901.8 7904.6 7837.6 7862.3 7904.8 7918.0 7918.7 39170.2 39565.6 39600.8 39639.0 39657.0 3034.6 3130.9 3200.4 3210.5 3684.6 29893.4 30027.1 30033.2 30098.2 30350.4 3370.6 3383.6 3417.7 3459.9 3558.9 254591.0 254698.0 255158.0 255201.0 255796.0 45207.3 50056.5 51239.7 51566.0 52692.7 46325.3 47526.8 49626.5 49630.3 50885.0 12986.0 13120.3 13145.0 13157.5 13160.2 9810.6 9862.5 9893.7 9904.4 10066.7 16624.4 16662.5 16674.6 16686.5 16690.7 6295.8 6386.5 6449.8 6579.2 6702.3 848.4 862.0 862.9 870.5 987.8 26620.3 27858.4 27897.9 27923.7 28224.9 927.4 956.1 965.9 967.0 1033.4 14516.5 14608.7 14679.0 14858.6 15140.2 112365.0 350597.0 350727.0 351497.0 352311.0 49852.0 50051.2 50095.5 50097.0 50143.0 1066.3 1149.7 1189.0 1191.6 1212.9 28101.2 28633.1 28924.7 29357.9 29444.6 42419.6 42580.6 42809.1 42930.8 42974.0 290650.0 291663.0 291830.0 293148.0 293536.0 31645.4 36221.0 36572.6 37532.6 37555.6 41904.4 42361.8 42611.6 42959.1 43785.6 36298.3 36357.6 36669.4 36988.6 37295.0 36282.5 36386.1 36518.3 36611.0 36754.8 35827.0 36939.0 37217.4 39013.6 39711.4 31364.5 33478.3 33609.5 33645.8 33878.0 24936.5 25415.7 25576.9 25643.7 25911.5 13:27:31 INFO - PROCESS | 26770 | 13:27:31 INFO - PROCESS | 26770 | [#2] jquery.html Cycles:180 Average:22965.37 Median:5129.63 stddev:60727.19 (1183.9%) stddev-sans-first:60873.81 13:27:31 INFO - PROCESS | 26770 | Values: 350.3 350.5 354.6 361.0 378.4 15993.4 17260.6 17352.4 17737.5 17767.6 16445.8 16695.0 17388.2 17442.7 17451.9 4949.5 5080.5 5133.5 5133.6 5133.7 3725.3 3891.8 5091.5 5592.0 5939.9 5959.4 5975.4 5981.8 5982.0 5993.0 5866.9 5868.2 5970.9 5981.1 6037.0 3375.8 4798.3 5125.8 5125.8 5262.0 19606.2 20075.9 20257.7 20543.4 20635.0 1789.2 1988.0 2270.2 2289.0 2514.7 9180.0 9192.4 9220.3 9539.7 11026.4 1721.9 1801.4 1807.3 1835.9 1903.1 65080.0 66085.0 66926.0 67088.7 67737.7 9646.6 9724.3 9732.0 9847.6 10078.2 13891.3 13940.3 13973.0 13973.1 14101.9 6709.3 6901.0 6932.1 7058.4 7139.5 6425.0 6461.4 6590.3 6612.1 6632.7 4009.0 4079.2 4100.1 4118.7 4162.7 1610.5 1661.0 1748.6 1804.9 1840.0 767.6 804.0 821.5 840.6 912.6 15731.8 16530.2 16533.0 16533.5 17175.3 834.9 837.3 847.9 850.9 867.4 9247.5 9267.1 9423.2 9485.2 9778.4 355343.0 364859.6 368702.0 369235.0 382294.0 69336.3 69818.7 71077.6 71147.0 71550.6 904.1 908.9 914.7 915.4 920.1 14682.8 14687.3 14687.6 14928.3 15306.0 32622.3 32661.8 33258.5 33524.5 33992.3 46196.8 46244.3 46466.3 46565.3 46571.1 4754.0 4898.0 6732.5 7181.5 7414.7 8053.9 10434.3 10993.0 11070.9 11314.4 8527.5 8805.2 8907.9 9193.4 9569.5 9643.5 9914.6 10162.3 10255.4 10350.8 5054.9 5155.0 9552.9 9835.5 9910.2 7424.5 7462.1 7487.6 7523.4 7686.5 7937.9 9394.0 9470.7 9494.4 9864.4 13:27:31 INFO - PROCESS | 26770 | 13:27:31 INFO - PROCESS | 26770 | [#3] mootools.html Cycles:180 Average:5256.25 Median:4617.22 stddev:3058.22 (66.2%) stddev-sans-first:3051.73 13:27:31 INFO - PROCESS | 26770 | Values: 1216.5 1389.4 1449.2 1517.6 1771.1 6904.2 7820.4 8064.8 8067.8 8326.3 8008.5 8152.4 8164.5 8166.7 8174.7 1877.1 2114.8 2132.6 2194.2 2256.6 2284.8 2295.6 2301.2 2303.6 2306.9 2194.1 2219.2 2230.0 2236.2 2237.4 1803.8 2059.5 2119.1 2128.9 2129.9 2165.1 2194.6 2195.2 2196.7 2197.5 8104.2 8176.6 8181.4 8185.3 8187.5 4626.4 4731.7 4743.5 4748.2 4750.8 2827.9 2840.6 2980.3 2995.9 3015.7 905.2 927.6 928.0 935.1 936.9 11319.8 11329.3 11338.3 11347.3 11359.3 4238.5 4279.2 4366.0 4404.7 4405.5 9541.4 9563.9 9567.3 9568.8 9574.7 4527.3 4582.1 4582.5 4586.8 4590.7 3534.9 4136.6 4243.3 4262.5 4302.6 3722.2 3728.6 3775.9 3851.9 3856.8 1200.6 1212.1 1223.4 1225.7 1234.0 774.9 794.4 796.6 798.5 819.9 4744.6 4878.9 4947.9 4974.4 5025.5 395.4 396.6 397.3 398.2 873.2 3310.3 3434.0 3446.7 3459.9 3471.4 9720.3 9996.4 10025.9 10039.0 10147.3 9951.2 10011.8 10024.1 10037.1 10044.0 7245.2 7473.2 7493.1 7716.0 7726.4 5018.6 5218.6 5235.6 5303.4 5333.2 9157.1 9214.1 9292.0 9378.3 9406.0 9237.5 9470.1 9484.7 9652.7 9661.7 5951.9 6656.2 6698.7 6780.1 6851.0 7667.2 7680.4 7744.7 7745.8 7753.1 6873.5 7051.6 7075.9 7176.0 7195.7 6961.5 6988.9 7044.2 7066.3 7076.7 6505.7 6575.4 6688.6 6693.0 6697.2 4458.7 4470.4 4499.0 4515.1 4530.2 4410.5 4543.0 4569.1 4587.2 4608.1 13:27:31 INFO - PROCESS | 26770 | 13:27:31 INFO - PROCESS | 26770 | [#4] prototype.html Cycles:180 Average:4064.29 Median:4430.87 stddev:1178.30 (26.6%) stddev-sans-first:1147.19 13:27:31 INFO - PROCESS | 26770 | Values: 297.5 305.6 312.4 313.8 317.5 4624.5 4810.6 4885.6 4888.5 4927.8 4645.4 4799.3 4817.1 4819.1 4845.0 3825.8 3828.3 3851.9 3857.2 3859.9 3594.5 3692.4 3837.8 3850.4 3871.3 3805.8 3806.3 3807.0 3811.8 3817.0 3782.7 3784.5 3786.8 3794.3 3805.1 3333.2 3351.1 3353.8 3368.5 3389.4 4568.8 4673.4 4675.7 4679.7 4682.7 4323.3 4326.5 4328.8 4329.5 4350.8 4918.0 5093.0 5106.2 5110.7 5120.5 3606.3 3617.3 3619.0 3624.7 3625.2 5213.6 5268.7 5312.8 5329.6 5345.3 3571.4 3675.5 3693.6 3705.1 3705.9 3678.7 3768.4 3782.7 3782.9 3783.3 4242.2 4244.6 4252.6 4293.4 4297.3 5038.9 5082.3 5087.2 5098.3 5107.4 1178.8 1226.9 1232.3 1283.9 1297.8 820.5 821.8 836.5 836.9 838.0 4025.3 4065.6 4069.9 4102.2 4117.7 4600.6 4604.2 4662.8 4672.5 4674.2 4073.3 4078.4 4095.6 4098.3 4106.4 2404.3 2466.0 2493.8 2504.4 2509.8 4397.3 4406.3 4408.7 4424.9 4432.4 4682.7 4714.8 4721.3 4726.3 4758.5 4223.4 4385.8 4408.7 4436.2 4459.0 4578.2 4611.6 4630.5 4659.8 4683.4 4498.9 4526.3 4583.7 4588.5 4601.5 4057.8 4364.4 4416.5 4429.4 4442.3 3280.8 3286.3 3290.7 3296.6 3308.7 4957.3 5061.9 5238.8 5270.9 5276.0 5036.8 5039.9 5040.8 5050.9 5080.3 4870.9 5030.6 5055.5 5076.8 5093.6 5026.9 5082.2 5091.6 5092.1 5093.5 5025.2 5070.0 5105.9 5128.3 5130.0 4848.3 4953.2 4975.5 5012.6 5016.8 13:27:31 INFO - PROCESS | 26770 | 13:27:31 INFO - PROCESS | 26770 | [#5] yui.html Cycles:180 Average:12679.32 Median:2356.69 stddev:14332.98 (608.2%) stddev-sans-first:14345.07 13:27:31 INFO - PROCESS | 26770 | Values: 724.5 743.9 755.4 758.4 761.9 11756.3 12517.2 12592.6 12593.4 12610.1 10535.7 11593.0 11610.8 11707.4 11710.8 757.9 779.5 780.7 791.4 791.7 784.2 789.2 790.8 791.5 792.8 664.1 801.4 839.5 840.0 840.3 806.2 808.6 809.3 810.0 813.5 596.0 596.6 597.3 597.3 597.9 12723.2 12730.0 12758.6 12760.4 12778.3 12211.9 12664.9 12690.2 12737.2 12953.6 10645.4 11015.5 11175.1 11178.9 11260.2 4087.8 4141.2 4155.1 4188.1 4266.6 45762.1 45888.8 45903.8 45911.3 45954.3 9779.2 9991.2 10188.7 10300.3 10641.9 16150.4 16187.5 16292.4 16318.9 16355.9 6626.9 6673.3 6693.7 6802.3 6854.4 3501.4 3503.8 3534.4 3627.9 3711.6 2748.9 2799.4 2835.4 2837.0 2842.9 533.4 558.4 567.5 572.8 577.0 407.9 480.8 496.5 524.6 535.1 7094.4 7208.6 7216.5 7273.6 7417.6 446.7 482.4 495.8 507.3 528.1 3511.5 3524.8 3539.8 3584.7 3603.1 41254.4 41289.8 41372.0 45835.5 46560.0 47298.8 48987.5 49282.3 49637.0 49954.0 45098.0 45809.0 45848.0 46455.5 46520.5 7753.2 7761.8 7843.9 8028.2 8279.7 29968.3 30436.5 31205.7 31743.0 31803.8 39412.0 39941.6 40120.2 40136.4 41266.8 9910.8 10423.1 10623.2 10818.6 10849.9 8345.3 10707.3 11110.8 11448.3 11929.7 10454.8 10514.9 10581.7 10727.6 10752.2 10582.6 10736.3 10742.0 10899.3 11540.4 10182.6 10619.3 10702.8 10718.8 10930.6 9584.8 9849.0 9963.0 9996.8 10050.6 8790.6 8878.4 9119.5 9153.2 9264.9 13:27:31 INFO - PROCESS | 26770 | -------- Summary: end -------- 13:27:31 INFO - PROCESS | 26770 | 13:27:31 INFO - TEST-INFO | 26770: exit 0 13:27:31 INFO - TEST-OK | dromaeo_css | took 1118958ms 13:27:31 INFO - TEST-START | kraken 13:27:31 INFO - operating with platform_type : linux_ 13:27:31 INFO - Initialising browser for kraken test... 13:27:31 INFO - TEST-INFO | started process 26949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEKVJne/profile http://localhost:45510/getInfo.html) 13:27:36 INFO - PROCESS | 26949 | __metrics Screen width/height:1600/1200 13:27:36 INFO - PROCESS | 26949 | colorDepth:24 13:27:36 INFO - PROCESS | 26949 | Browser inner width/height: 1024/697 13:27:36 INFO - PROCESS | 26949 | __metrics 13:27:37 ERROR - PROCESS | 26949 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:27:37 INFO - TEST-INFO | 26949: exit 0 13:27:37 INFO - Browser initialized. 13:27:37 INFO - Running cycle 1/1 for kraken test... 13:27:37 INFO - TEST-INFO | started process 27028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEKVJne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:49 INFO - PROCESS | 27028 | RSS: Main: 156602368 13:27:49 INFO - PROCESS | 27028 | 13:27:52 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45510/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:53 INFO - PROCESS | 27028 | RSS: Main: 212193280 13:27:53 INFO - PROCESS | 27028 | 13:27:56 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45510/tests/kraken/driver.html?testName=audio-dft) 13:27:56 INFO - PROCESS | 27028 | RSS: Main: 200622080 13:27:56 INFO - PROCESS | 27028 | 13:28:00 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45510/tests/kraken/driver.html?testName=audio-fft) 13:28:00 INFO - PROCESS | 27028 | RSS: Main: 269209600 13:28:00 INFO - PROCESS | 27028 | 13:28:02 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45510/tests/kraken/driver.html?testName=audio-oscillator) 13:28:03 INFO - PROCESS | 27028 | RSS: Main: 178114560 13:28:03 INFO - PROCESS | 27028 | 13:28:05 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:28:06 INFO - PROCESS | 27028 | RSS: Main: 182206464 13:28:06 INFO - PROCESS | 27028 | 13:28:09 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45510/tests/kraken/driver.html?testName=imaging-darkroom) 13:28:10 INFO - PROCESS | 27028 | RSS: Main: 217944064 13:28:10 INFO - PROCESS | 27028 | 13:28:13 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45510/tests/kraken/driver.html?testName=imaging-desaturate) 13:28:14 INFO - PROCESS | 27028 | RSS: Main: 218869760 13:28:14 INFO - PROCESS | 27028 | 13:28:17 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45510/tests/kraken/driver.html?testName=json-parse-financial) 13:28:17 INFO - PROCESS | 27028 | RSS: Main: 218951680 13:28:17 INFO - PROCESS | 27028 | 13:28:19 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:19 INFO - PROCESS | 27028 | RSS: Main: 205774848 13:28:19 INFO - PROCESS | 27028 | 13:28:21 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45510/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:22 INFO - PROCESS | 27028 | RSS: Main: 209596416 13:28:22 INFO - PROCESS | 27028 | 13:28:24 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:25 INFO - PROCESS | 27028 | RSS: Main: 221618176 13:28:25 INFO - PROCESS | 27028 | 13:28:28 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:28:28 INFO - PROCESS | 27028 | RSS: Main: 227774464 13:28:28 INFO - PROCESS | 27028 | 13:28:31 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:32 INFO - PROCESS | 27028 | RSS: Main: 223440896 13:28:32 INFO - PROCESS | 27028 | 13:28:33 INFO - PROCESS | 27028 | Cycle 1(1): loaded http://localhost:45510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45510/tests/kraken/driver.html?testName=ai-astar) 13:28:34 INFO - PROCESS | 27028 | RSS: Main: 268050432 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | __start_tp_report 13:28:34 INFO - PROCESS | 27028 | _x_x_mozilla_page_load 13:28:34 INFO - PROCESS | 27028 | _x_x_mozilla_page_load_details 13:28:34 INFO - PROCESS | 27028 | |i|pagename|runs| 13:28:34 INFO - PROCESS | 27028 | |0;ai-astar;113;112;113;115;112;114;113;114;113;114 13:28:34 INFO - PROCESS | 27028 | |1;audio-beat-detection;158;131;137;164;134;153;155;130;198;129 13:28:34 INFO - PROCESS | 27028 | |2;audio-dft;161;161;160;161;160;161;162;160;162;163 13:28:34 INFO - PROCESS | 27028 | |3;audio-fft;77;76;74;111;76;77;75;75;99;76 13:28:34 INFO - PROCESS | 27028 | |4;audio-oscillator;85;85;127;84;85;84;120;84;83;124 13:28:34 INFO - PROCESS | 27028 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 13:28:34 INFO - PROCESS | 27028 | |6;imaging-darkroom;146;146;147;146;147;146;146;146;146;146 13:28:34 INFO - PROCESS | 27028 | |7;imaging-desaturate;95;94;94;95;95;95;95;94;94;95 13:28:34 INFO - PROCESS | 27028 | |8;json-parse-financial;64;65;65;65;64;65;66;90;63;61 13:28:34 INFO - PROCESS | 27028 | |9;json-stringify-tinderbox;66;66;66;66;66;66;66;65;65;66 13:28:34 INFO - PROCESS | 27028 | |10;stanford-crypto-aes;84;82;88;85;91;85;90;83;84;83 13:28:34 INFO - PROCESS | 27028 | |11;stanford-crypto-ccm;128;131;129;129;128;131;129;127;172;139 13:28:34 INFO - PROCESS | 27028 | |12;stanford-crypto-pbkdf2;173;177;177;173;172;168;170;172;169;169 13:28:34 INFO - PROCESS | 27028 | |13;stanford-crypto-sha256-iterative;68;66;66;67;68;66;65;66;66;71 13:28:34 INFO - PROCESS | 27028 | __end_tp_report 13:28:34 INFO - PROCESS | 27028 | __start_cc_report 13:28:34 INFO - PROCESS | 27028 | _x_x_mozilla_cycle_collect,1920 13:28:34 INFO - PROCESS | 27028 | __end_cc_report 13:28:34 INFO - PROCESS | 27028 | __startTimestamp1464294514164__endTimestamp 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | ------- Summary: start ------- 13:28:34 INFO - PROCESS | 27028 | Number of tests: 14 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:0.95 (0.8%) stddev-sans-first:1.00 13:28:34 INFO - PROCESS | 27028 | Values: 113.0 112.0 113.0 115.0 112.0 114.0 113.0 114.0 113.0 114.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.00 stddev:21.64 (14.0%) stddev-sans-first:22.70 13:28:34 INFO - PROCESS | 27028 | Values: 158.0 131.0 137.0 164.0 134.0 153.0 155.0 130.0 198.0 129.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 13:28:34 INFO - PROCESS | 27028 | Values: 161.0 161.0 160.0 161.0 160.0 161.0 162.0 160.0 162.0 163.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.69 (16.7%) stddev-sans-first:13.35 13:28:34 INFO - PROCESS | 27028 | Values: 77.0 76.0 74.0 111.0 76.0 77.0 75.0 75.0 99.0 76.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:84.00 stddev:19.10 (22.7%) stddev-sans-first:19.84 13:28:34 INFO - PROCESS | 27028 | Values: 85.0 85.0 127.0 84.0 85.0 84.0 120.0 84.0 83.0 124.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:28:34 INFO - PROCESS | 27028 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 13:28:34 INFO - PROCESS | 27028 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:28:34 INFO - PROCESS | 27028 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:65.00 stddev:8.27 (12.7%) stddev-sans-first:8.71 13:28:34 INFO - PROCESS | 27028 | Values: 64.0 65.0 65.0 65.0 64.0 65.0 66.0 90.0 63.0 61.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 13:28:34 INFO - PROCESS | 27028 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 66.0 65.0 65.0 66.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:3.10 (3.6%) stddev-sans-first:3.24 13:28:34 INFO - PROCESS | 27028 | Values: 84.0 82.0 88.0 85.0 91.0 85.0 90.0 83.0 84.0 83.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:130.00 stddev:13.67 (10.5%) stddev-sans-first:14.31 13:28:34 INFO - PROCESS | 27028 | Values: 128.0 131.0 129.0 129.0 128.0 131.0 129.0 127.0 172.0 139.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.50 stddev:3.16 (1.8%) stddev-sans-first:3.33 13:28:34 INFO - PROCESS | 27028 | Values: 173.0 177.0 177.0 173.0 172.0 168.0 170.0 172.0 169.0 169.0 13:28:34 INFO - PROCESS | 27028 | 13:28:34 INFO - PROCESS | 27028 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:1.73 (2.6%) stddev-sans-first:1.79 13:28:34 INFO - PROCESS | 27028 | Values: 68.0 66.0 66.0 67.0 68.0 66.0 65.0 66.0 66.0 71.0 13:28:34 INFO - PROCESS | 27028 | -------- Summary: end -------- 13:28:34 INFO - PROCESS | 27028 | 13:28:35 INFO - TEST-INFO | 27028: exit 0 13:28:35 INFO - TEST-OK | kraken | took 63393ms 13:28:35 INFO - SUITE-END | took 1182s 13:28:35 INFO - Completed test suite (00:19:42) 13:28:35 INFO - javascript benchmark 13:28:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.494696007758, 2678.9464210715773, 2700.7839372850176, 2707.837529748215, 2713.9144342263094, 4681.742504162274, 4739.620830333573, 4765.8808529786775, 4804.20730579454, 4843.079814835179, 4750.714957102577, 4808.615310775138, 4815.205491093974, 4834.371531700874, 4883.706977581339, 4363.847265345714, 4370.125974805036, 4399.802008909607, 4428.424304840374, 4495.842645507408, 4426.955730442703, 4469.463664360282, 4546.136234115507, 4583.908321833561, 4601.493835678073, 4356.43366362374, 4498.460184777815, 4527.569880861313, 4551.340055691906, 4556.8860778480475, 4391.3193455014525, 4408.889777755549, 4409.625181859546, 4416.183006143874, 4447.533009034038, 4378.868633940955, 4437.201303765353, 4447.644188464915, 4464.6874718769695, 4500.819967201308, 4669.836555720567, 4812.230043193107, 4830.396200474941, 4832.081904438181, 4849.054434385296, 5090.847274581768, 5153.0, 5157.948420515784, 5215.6349055566125, 5219.530242278175, 5220.347456567929, 5222.73886305687, 5240.973795131038, 5247.23915032322, 5251.579873610102, 4728.219843725747, 4797.664163508521, 4850.490698476609, 4899.387576552931, 4908.779104940286, 5295.364556253275, 5305.4164041955355, 5352.090144675414, 5356.1697936819855, 5362.195670649356, 5118.718470484085, 5128.358955130609, 5161.767720452589, 5167.612429067835, 5175.146100893386, 4925.408950925912, 5149.845504634867, 5213.687178769286, 5256.684598924076, 5271.209318602164, 5175.301334319894, 5184.688918664892, 5190.714510701948, 5192.844214673566, 5224.111900976843, 5142.537171654569, 5165.302684137593, 5166.844994650167, 5172.586193104543, 5219.608529360313, 4364.170807546556, 4406.977965110218, 4411.889702757457, 4418.469783625986, 4487.439070116236, 3870.4194370844034, 3875.8643447479767, 3895.5130608673917, 3928.017995501125, 3975.960240397617, 4483.30508771141, 4485.842995495207, 4492.797824097924, 4537.478190008192, 4541.977290113595, 5061.569766569883, 5178.197379406198, 5229.424763276036, 5247.134222853263, 5265.868353291198, 4480.977595112004, 4498.437695288089, 4507.864764057083, 4542.84100056503, 4547.363369128325, 4747.928781068286, 4752.287156926489, 4752.596029337545, 4755.95486007815, 4807.759612019385, 4764.28535719631, 4817.638677099161, 4848.5636292733825, 4859.00390419956, 4916.410030796327, 5189.221616757516, 5209.6092793041435, 5214.348206474191, 5214.504622060898, 5254.97372513135, 4844.370231869834, 4874.390701162355, 4874.463808981081, 4887.951120488749, 4922.556969872729, 4943.382077240345, 5101.336826212569, 5108.131617625087, 5122.231665250242, 5179.974100129475, 5249.527542521038, 5264.657797243167, 5268.683878967274, 5279.498447647467, 5285.101532739367, 5118.283440318284, 5121.7695203715175, 5124.231365295235, 5138.0, 5159.638825282194, 4910.729909854849, 4970.353853999101, 5007.048660754445, 5038.672486288379, 5065.366829146356, 4959.057779021974, 4973.801047958041, 4981.252812078217, 5004.3494345734825, 5023.648344615842, 4889.975550122226, 5078.4667609900425, 5082.136036873814, 5121.07820592297, 5130.7178105204575, 4923.581495572773, 5009.398872135367, 5019.64862459639, 5034.993001399662, 5037.571806396498], "value": 4768.387269351512, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.2282887176451, 598.2163365990551, 598.5092224376011, 598.9670568118752, 599.9370066143052, 39226.21547569051, 40411.59588404115, 40417.39373909394, 40557.3916391254, 44964.0, 42227.78886105573, 42642.786786066026, 42701.14597708044, 42751.78624106883, 42818.57181428185, 7766.184550622174, 7934.44458887878, 7951.085625153123, 7951.324137448295, 7952.840943181133, 7829.882551761728, 7929.762107136795, 7930.048394192676, 7931.801704957394, 7934.920650793476, 7896.960515197416, 7925.0, 7928.524288542677, 7939.325157361603, 7943.761687149395, 7828.256315650033, 7897.763067107996, 7899.644515996794, 7901.802454938673, 7904.565248911307, 7837.568933708644, 7862.331701805296, 7904.762857114296, 7918.0, 7918.683252669886, 39170.216595668215, 39565.60434395648, 39600.80199598984, 39639.0, 39657.0, 3034.575159477675, 3130.8904188353526, 3200.391925534141, 3210.4702724050503, 3684.6315368463206, 29893.40213195724, 30027.099187024425, 30033.249168770737, 30098.24754381136, 30350.392992140034, 3370.5955285365667, 3383.644717304672, 3417.709494692954, 3459.9481007784902, 3558.9110272243142, 254591.0, 254698.0, 255158.0, 255201.0, 255796.0, 45207.321890171675, 50056.499435005186, 51239.743801280754, 51566.0, 52692.736536317076, 46325.30512042322, 47526.76236618864, 49626.503734962185, 49630.25554616684, 50885.0, 12986.0, 13120.278384688743, 13145.014123940742, 13157.473701052042, 13160.210387376788, 9810.607575697035, 9862.457564834003, 9893.703188904345, 9904.356216845881, 10066.69799906004, 16624.418145364853, 16662.500124996026, 16674.58313542171, 16686.499405017625, 16690.66618667644, 6295.811125666238, 6386.457151142112, 6449.809022143427, 6579.2104947406615, 6702.329767023356, 848.3976376772438, 861.9913800862037, 862.9266512346395, 870.4516154822421, 987.8468837330082, 26620.334491637477, 27858.442831143264, 27897.891897292193, 27923.72076279252, 28224.85887570549, 927.4157280912982, 956.1490273656451, 965.9275554333453, 966.9613215471443, 1033.4109557552124, 14516.491922782652, 14608.707825843636, 14679.0, 14858.628534286514, 15140.242987850563, 112365.0, 350597.0, 350727.0, 351497.0, 352311.0, 49852.0, 50051.24923126156, 50095.499045009085, 50096.99999999927, 50143.0, 1066.3015724700178, 1149.7298134938283, 1188.9702757431132, 1191.624638238952, 1212.8847759463013, 28101.156965291073, 28633.14100576986, 28924.710752892202, 29357.85321073381, 29444.558331624616, 42419.5758042428, 42580.574194257664, 42809.1438171241, 42930.78534607307, 42974.0, 290650.0, 291663.0, 291830.0, 293148.0, 293536.0, 31645.36709265848, 36221.0, 36572.63427365692, 37532.624673752915, 37555.62444375631, 41904.3714344279, 42361.78819105885, 42611.57388426076, 42959.1408171841, 43785.56214437942, 36298.27403451863, 36357.63642363543, 36669.449958250116, 36988.63011369852, 37295.0, 36282.4557631641, 36386.09034774152, 36518.26963460663, 36611.0, 36754.8162259187, 35826.95470885004, 36939.0, 37217.4417383734, 39013.609863900994, 39711.40432893567, 31364.529532057495, 33478.33043339168, 33609.495857562644, 33645.83177084099, 33878.0, 24936.501269974862, 25415.74584254134, 25576.872115639304, 25643.743562564883, 25911.481770364866], "value": 17488.39599855798, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.264444666201, 350.5092869982026, 354.58159371941133, 361.0414349901014, 378.38701303887706, 15993.360265589377, 17260.568485787844, 17352.392666256685, 17737.46787596371, 17767.55581110473, 16445.83554164458, 16694.998300102, 17388.21753021114, 17442.651146977052, 17451.91274043628, 4949.50504949504, 5080.466551012146, 5133.460986596409, 5133.563647090002, 5133.666311689728, 3725.329440700673, 3891.824867880938, 5091.541761241488, 5591.9720401398135, 5939.88120237595, 5959.433853783884, 5975.372585878486, 5981.760729570812, 5982.042873140276, 5992.9700351498395, 5866.882662346729, 5868.2371291732015, 5970.8805823883495, 5981.102834574827, 6037.0, 3375.763696541243, 4798.304245884327, 5125.794968201268, 5125.794968201268, 5262.0, 19606.215751369928, 20075.89962050195, 20257.696134557995, 20543.38369848907, 20635.0, 1789.2485156234284, 1987.960240795176, 2270.1713874435713, 2289.004283136841, 2514.7233804281514, 9179.954100229523, 9192.35653504255, 9220.308476864195, 9539.713808585753, 11026.393548354838, 1721.8794684372099, 1801.3737949601057, 1807.2590238002356, 1835.8898466091944, 1903.077007651288, 65080.0, 66085.0, 66926.0, 67088.6645566774, 67737.66131169412, 9646.601242819752, 9724.319297649097, 9732.0, 9847.60609575609, 10078.244131690153, 13891.305434728223, 13940.302984850718, 13973.0, 13973.09174903628, 14101.929490352482, 6709.261981182066, 6900.965495172492, 6932.064171336805, 7058.364747172779, 7139.464540159509, 6424.967875160594, 6461.418472337512, 6590.3080176581725, 6612.140421745238, 6632.668366581652, 4008.9599104008585, 4079.204555111725, 4100.134438830325, 4118.711690181659, 4162.729422587522, 1610.492694801134, 1660.96678066438, 1748.5685835200397, 1804.9097545122954, 1839.981600183981, 767.5897681280783, 803.9799005024921, 821.5235163605095, 840.6259214649544, 912.5619702542684, 15731.764023539656, 16530.173491325386, 16533.0, 16533.50399488017, 17175.31298748036, 834.8872902158131, 837.3008537870946, 847.872819077131, 850.9361797865184, 867.418829384314, 9247.491387973592, 9267.119623635745, 9423.246140308758, 9485.241180705527, 9778.364406313567, 355343.0, 364859.6374613325, 368702.0, 369235.0, 382294.0, 69336.30663693299, 69818.65090674616, 71077.64461177662, 71147.0, 71550.64224678843, 904.0507467159456, 908.9136532029447, 914.7118657622827, 915.3958387464374, 920.1488623023677, 14682.80117414504, 14687.265636718335, 14687.632809179857, 14928.253587320807, 15306.0, 32622.34755304928, 32661.836690817345, 33258.50112248366, 33524.49713254254, 33992.320153596294, 46196.76901615471, 46244.306335404326, 46466.30300545427, 46565.3015204779, 46571.06857862892, 4753.952460475351, 4898.0, 6732.495062870206, 7181.461390395637, 7414.702427075348, 8053.919460805317, 10434.269601127848, 10993.0, 11070.889291106985, 11314.434278285888, 8527.53098579584, 8805.207531322212, 8907.866382004404, 9193.448393096436, 9569.473678947446, 9643.469609171283, 9914.553845076845, 10162.339447935861, 10255.435951022468, 10350.844737328796, 5054.924176137434, 5155.0, 9552.90447095548, 9835.459049752333, 9910.15763660097, 7424.480286379901, 7462.10454745434, 7487.625618719151, 7523.3981281498445, 7686.538807671334, 7937.920620793718, 9393.953030234805, 9470.668526601536, 9494.430334179971, 9864.408135511892], "value": 7880.914880743415, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1216.4586758892285, 1389.3608939887654, 1449.2101804516537, 1517.5750789778858, 1771.1232939694844, 6904.240533541312, 7820.3743700503965, 8064.758057258277, 8067.838643227139, 8326.333893288538, 8008.479448835822, 8152.429329946906, 8164.469309494879, 8166.67333306667, 8174.6730130794695, 1877.1271358818146, 2114.756802967663, 2132.552164045552, 2194.1552502286654, 2256.5825322315422, 2284.8400611957086, 2295.6097463431174, 2301.2060839010596, 2303.6429353450158, 2306.8615883046987, 2194.1333173396497, 2219.2343641443676, 2229.9888500557477, 2236.206146817881, 2237.429455488856, 1803.8196180381922, 2059.4542446251753, 2119.1417475922276, 2128.8935553222277, 2129.9041543130443, 2165.07984106754, 2194.561087782434, 2195.1877805212175, 2196.6595177747477, 2197.48359135603, 8104.230098140667, 8176.632051557634, 8181.3863960202625, 8185.3451723861945, 8187.467814592092, 4626.352310676508, 4731.69243999139, 4743.525647435264, 4748.216544270226, 4750.786214620351, 2827.915162545127, 2840.630718006646, 2980.314527658629, 2995.925101872449, 3015.6531998820196, 905.226031742857, 927.6039560461462, 927.9628814847398, 935.0696057422907, 936.9109934556207, 11319.830202546967, 11329.263597866195, 11338.263012904217, 11347.262427942158, 11359.261647992855, 4238.470191226097, 4279.165562715303, 4366.0, 4404.713693609905, 4405.493368262691, 9541.379810312308, 9563.856542151872, 9567.330286879851, 9568.76078098053, 9574.712758617252, 4527.320901864747, 4582.083583283356, 4582.450105987236, 4586.816527338936, 4590.747508886977, 3534.9469757953652, 4136.627703506699, 4243.2998555238655, 4262.488501379792, 4302.612764851178, 3722.181120153562, 3728.571214310389, 3775.9433608495897, 3851.9037024074623, 3856.807159642007, 1200.5797970710182, 1212.0848759186758, 1223.3577371879655, 1225.6874497003207, 1233.9876601233873, 774.883767434878, 794.4359504751576, 796.5857753967904, 798.4650284309527, 819.9098099209082, 4744.596709279681, 4878.853634390974, 4947.876303092451, 4974.369468971332, 5025.47232540578, 395.4483495523786, 396.61528317531946, 397.31264911702914, 398.2055798681591, 873.1792115411492, 3310.3213841162506, 3434.0, 3446.724262059029, 3459.9135021624156, 3471.3751524725285, 9720.270979676552, 9996.400215986918, 10025.94727553611, 10039.0, 10147.289689721796, 9951.15415189717, 10011.79976400468, 10024.147947424404, 10037.146842518321, 10044.0, 7245.166805817398, 7473.215312392121, 7493.100827900686, 7716.0, 7726.420518461138, 5018.573421259088, 5218.582513398843, 5235.554977826928, 5303.443138470405, 5333.173358129496, 9157.130072643089, 9214.078592141, 9292.0, 9378.296627752808, 9405.95297023538, 9237.491937943478, 9470.100340467645, 9484.668036618685, 9652.662156824477, 9661.661841835503, 5951.851203719942, 6656.167979002625, 6698.698558564779, 6780.118584583973, 6850.965745171242, 7667.194944530744, 7680.385569154566, 7744.6902123914415, 7745.806354841174, 7753.069631644239, 6873.450123989969, 7051.576905385693, 7075.929240707733, 7176.0, 7195.71217151329, 6961.477889158435, 6988.860222795617, 7044.189918159477, 7066.258042905421, 7076.716931322895, 6505.7072431741635, 6575.375339342755, 6688.632125232964, 6693.0, 6697.162854643169, 4458.7324760514475, 4470.441194850644, 4499.0, 4515.051839113691, 4530.161920044802, 4410.470743510799, 4542.954570454253, 4569.086182763527, 4587.151376995266, 4608.078384323216], "value": 4132.226365227239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.5165356296019, 305.60424250595474, 312.362779928945, 313.78662509493535, 317.4793338924165, 4624.468186158593, 4810.639202059842, 4885.63357748169, 4888.486708895563, 4927.802887884485, 4645.374119058336, 4799.280107983805, 4817.108834865552, 4819.1325561398935, 4845.0, 3825.7895815730126, 3828.3300422426105, 3851.903702407434, 3857.1514266861245, 3859.903502412434, 3594.4967704521387, 3692.4461330800327, 3837.827297771607, 3850.3646898261754, 3871.2838124946834, 3805.771653700773, 3806.2768074065975, 3806.9619303806885, 3811.752236104658, 3817.0075780297184, 3782.6595606395417, 3784.4701741756176, 3786.810659467043, 3794.330494582389, 3805.1248212911187, 3333.1500467380906, 3351.0784534253276, 3353.782004169721, 3368.4947257911263, 3389.4407422775457, 4568.771561421916, 4673.439187297546, 4675.672702910798, 4679.672422930396, 4682.719036857799, 4323.308270676676, 4326.502452217972, 4328.783560821947, 4329.5453977332245, 4350.782460876943, 4917.950820491785, 5092.9745351273, 5106.208537676666, 5110.718910459923, 5120.49095942989, 3606.2607165531003, 3617.276544691072, 3619.0, 3624.676992897573, 3625.2386998730035, 5213.635045546814, 5268.683878967236, 5312.787488500456, 5329.626926115174, 5345.30511033567, 3571.357295387872, 3675.5221821163077, 3693.612170722089, 3705.1478160023344, 3705.9073523161596, 3678.7240956928335, 3768.3970564709516, 3782.6973842092566, 3782.9432558511644, 3783.2622638585763, 4242.151569686075, 4244.639205667553, 4252.596003379674, 4293.355996600472, 4297.333913243452, 5038.916632923939, 5082.313887625123, 5087.186050231945, 5098.337216161875, 5107.41264754558, 1178.7996040673106, 1226.920250183753, 1232.3160645841645, 1283.8972882169592, 1297.8053292006086, 820.5158956215861, 821.8356328734277, 836.4646626159263, 836.9120143813019, 837.9512092932843, 4025.335819589735, 4065.6137666921595, 4069.877903662895, 4102.2000709861295, 4117.711760176819, 4600.631949444037, 4604.194266003503, 4662.790174442158, 4672.5327467253, 4674.205385084544, 4073.327900896378, 4078.3882417636996, 4095.5904409558807, 4098.323776576891, 4106.425100485934, 2404.3388068281015, 2465.963010554843, 2493.8254322197636, 2504.4114633061217, 2509.7992160627105, 4397.2964325707735, 4406.294992801137, 4408.6854401439505, 4424.911501770011, 4432.3794668746405, 4682.695624784378, 4714.750591093363, 4721.268203428405, 4726.26742854858, 4758.500357462486, 4223.429836972031, 4385.780710964439, 4408.713433626804, 4436.223660859401, 4458.977705111453, 4578.198815207392, 4611.608013318905, 4630.536946305478, 4659.767011649472, 4683.391159149289, 4498.8875278117, 4526.275795872644, 4583.74789386587, 4588.4952655207235, 4601.492186758158, 4057.776822274803, 4364.410804541346, 4416.492103408149, 4429.357743127164, 4442.333649952533, 3280.803151810899, 3286.326303107905, 3290.6709329066903, 3296.587926509186, 3308.669133086672, 4957.330760347451, 5061.924071138862, 5238.790448382022, 5270.868228294324, 5276.0, 5036.798528058836, 5039.899202015866, 5040.832442049954, 5050.888804463012, 5080.339555857862, 4870.878228044327, 5030.622703297194, 5055.51972562606, 5076.796928122833, 5093.592512599057, 5026.874328141826, 5082.161443361952, 5091.643584949018, 5092.134337162765, 5093.548338723446, 5025.221090730943, 5070.0, 5105.897882042413, 5128.333316668809, 5130.0, 4848.296996935354, 4953.23224900141, 4975.502449754996, 5012.598992080698, 5016.824411145592], "value": 3694.722561761647, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.5145752345928, 743.9404847612192, 755.4485225785177, 758.3932853717032, 761.8666733321671, 11756.294622322655, 12517.24896506208, 12592.622221333364, 12593.433295501702, 12610.117291789578, 10535.683929482127, 11593.0, 11610.767784644302, 11707.356095414749, 11710.765784684301, 757.9431542634297, 779.5050143159107, 780.683823051665, 791.4064451661254, 791.70311133325, 784.231453175888, 789.2462698123278, 790.7746292306693, 791.5211297165218, 792.7740593930731, 664.1134085995202, 801.3629164813958, 839.471133186092, 840.0213750980101, 840.306746933779, 806.1776987472745, 808.6441965535146, 809.348474478045, 809.9838003239902, 813.4549851599413, 596.0314488955447, 596.6062398816804, 597.2772944736873, 597.2981746447906, 597.9491743201833, 12723.23660580368, 12730.0, 12758.553450629184, 12760.425780839885, 12778.297193654345, 12211.93894030533, 12664.936675316565, 12690.238585684796, 12737.235765854079, 12953.611391658265, 10645.361278323247, 11015.504302306415, 11175.050120739746, 11178.888211117948, 11260.21178517504, 4087.7956102195067, 4141.233871733739, 4155.065110350177, 4188.141431006637, 4266.637335826458, 45762.08475830465, 45888.77055614734, 45903.77048114738, 45911.31133033007, 45954.31068533975, 9779.168770654574, 9991.150752186, 10188.694339169837, 10300.330478518872, 10641.89358106409, 16150.353985840435, 16187.514374568782, 16292.42976495817, 16318.918405407898, 16355.91822040906, 6626.933730662631, 6673.265940746514, 6693.665316734144, 6802.319768023158, 6854.417374523221, 3501.352249833789, 3503.7722548034294, 3534.3638145134123, 3627.9093022674115, 3711.573169085536, 2748.8625568721486, 2799.3701417180973, 2835.3762172322467, 2836.971630283712, 2842.8862845486365, 533.4079172118945, 558.3969313141797, 567.492094575361, 572.7880684146892, 577.0305886111289, 407.94492743479844, 480.8485327121945, 496.48117716985837, 524.593440083938, 535.0796629796744, 7094.396976257076, 7208.639568021578, 7216.530925489827, 7273.563586184846, 7417.554946703215, 446.74312270444625, 482.35364611420863, 495.8016793282716, 507.28979428799977, 528.0626887275041, 3511.543499345069, 3524.8413821377585, 3539.752217344761, 3584.6594573515476, 3603.0992251937014, 41254.38118428226, 41289.79355103205, 41372.0, 45835.54164458313, 46560.0, 47298.763506182935, 48987.51012489901, 49282.26076608854, 49637.0, 49954.0, 45098.0, 45809.0, 45848.0, 46455.535444645124, 46520.53479465162, 7753.185915479019, 7761.7671469855995, 7843.882341764992, 8028.197180281925, 8279.710210142615, 29968.25079373033, 30436.543451847796, 31205.68794312028, 31743.0, 31803.840980795874, 39412.0, 39941.600583993786, 40120.1975960485, 40136.39795403013, 41266.79366603148, 9910.801783964136, 10423.061924426838, 10623.150147988297, 10818.567257309935, 10849.945750271514, 8345.332373410234, 10707.250492465453, 11110.833337500106, 11448.255863368855, 11929.701757456132, 10454.843177352193, 10514.94742526313, 10581.735456613646, 10727.570897164338, 10752.247342685936, 10582.629607963685, 10736.30214036085, 10742.0, 10899.29154604948, 11540.422978850856, 10182.592696292066, 10619.30974486656, 10702.83945740799, 10718.785624287626, 10930.56277748881, 9584.808303834025, 9848.950755246178, 9963.003699629979, 9996.750081248027, 10050.597976080875, 8790.648374064966, 8878.422902511316, 9119.452832830051, 9153.17621414076, 9264.861027084735], "value": 5846.014037488649, "unit": "score"}], "name": "dromaeo_css", "value": 6233.457060480878, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 115.0, 112.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 137.0, 164.0, 134.0, 153.0, 155.0, 130.0, 198.0, 129.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 160.0, 162.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 111.0, 76.0, 77.0, 75.0, 75.0, 99.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 127.0, 84.0, 85.0, 84.0, 120.0, 84.0, 83.0, 124.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 66.0, 90.0, 63.0, 61.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 88.0, 85.0, 91.0, 85.0, 90.0, 83.0, 84.0, 83.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 129.0, 129.0, 128.0, 131.0, 129.0, 127.0, 172.0, 139.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 177.0, 177.0, 173.0, 172.0, 168.0, 170.0, 172.0, 169.0, 169.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 67.0, 68.0, 66.0, 65.0, 66.0, 66.0, 71.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1549.9, "alertThreshold": 2.0}]} 13:28:35 INFO - Return code: 0 13:28:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:28:35 ERROR - # TBPL SUCCESS # 13:28:35 INFO - Running post-action listener: _resource_record_post_action 13:28:35 INFO - ##### 13:28:35 INFO - ##### Finished run-tests step (success) 13:28:35 INFO - ##### 13:28:35 INFO - Running post-run listener: _resource_record_post_run 13:28:35 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 394596352; Read time: 0; Write time: 228556 13:28:35 INFO - TinderboxPrint: CPU usage
13.2% 13:28:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:28:35 INFO - TinderboxPrint: I/O write bytes / time
394,596,352 / 228,556 13:28:35 INFO - TinderboxPrint: CPU idle
8,309.0 (86.8%) 13:28:35 INFO - TinderboxPrint: CPU user
1,217.2 (12.7%) 13:28:35 INFO - TinderboxPrint: Swap in / out
0 / 0 13:28:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110460928; Read time: 0; Write time: 75940 13:28:35 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284135424; Read time: 0; Write time: 152616 13:28:36 INFO - Running post-run listener: _upload_blobber_files 13:28:36 INFO - Blob upload gear active. 13:28:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:28:36 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 13:28:36 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'] 13:28:36 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 13:28:36 INFO - (blobuploader) - INFO - Open directory for files ... 13:28:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:28:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:28:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:37 INFO - (blobuploader) - INFO - Done attempting. 13:28:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:28:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:42 INFO - (blobuploader) - INFO - Done attempting. 13:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:43 INFO - (blobuploader) - INFO - Done attempting. 13:28:43 INFO - (blobuploader) - INFO - Iteration through files over. 13:28:43 INFO - Return code: 0 13:28:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/513e7c3371e4035e0f7a65df959518c51106a201cb0755527fd05e2729fc3bfa937f6ec06efeb39b51d39dec6c167c374ea30e636b1f7333087acd1590529071", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3eebb0c8529252cebeba8c1053ee317209cc6ff70670a590bc6f9335245e7d55be325ec28e642918105df70fba8bce522715875489bbd364f89a491fd2758ac1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d9dafb6f336564e2b773548a132e038baa314d45252e37aa244b7d5e0d76c4442137e6e52ec4e6f867b9e8ca1c30e0d129a3565837ebf806c915e4237f501dd"} 13:28:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:43 INFO - Contents: 13:28:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/513e7c3371e4035e0f7a65df959518c51106a201cb0755527fd05e2729fc3bfa937f6ec06efeb39b51d39dec6c167c374ea30e636b1f7333087acd1590529071", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3eebb0c8529252cebeba8c1053ee317209cc6ff70670a590bc6f9335245e7d55be325ec28e642918105df70fba8bce522715875489bbd364f89a491fd2758ac1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d9dafb6f336564e2b773548a132e038baa314d45252e37aa244b7d5e0d76c4442137e6e52ec4e6f867b9e8ca1c30e0d129a3565837ebf806c915e4237f501dd"} 13:28:43 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:43 INFO - Copying logs to upload dir... 13:28:43 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.109930 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-26 13:28:42.892111) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 13:28:42.896079) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135 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/513e7c3371e4035e0f7a65df959518c51106a201cb0755527fd05e2729fc3bfa937f6ec06efeb39b51d39dec6c167c374ea30e636b1f7333087acd1590529071", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3eebb0c8529252cebeba8c1053ee317209cc6ff70670a590bc6f9335245e7d55be325ec28e642918105df70fba8bce522715875489bbd364f89a491fd2758ac1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d9dafb6f336564e2b773548a132e038baa314d45252e37aa244b7d5e0d76c4442137e6e52ec4e6f867b9e8ca1c30e0d129a3565837ebf806c915e4237f501dd"} build_url:https://queue.taskcluster.net/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/UdM5_0KAS5S8YGWCtN4PJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/513e7c3371e4035e0f7a65df959518c51106a201cb0755527fd05e2729fc3bfa937f6ec06efeb39b51d39dec6c167c374ea30e636b1f7333087acd1590529071", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3eebb0c8529252cebeba8c1053ee317209cc6ff70670a590bc6f9335245e7d55be325ec28e642918105df70fba8bce522715875489bbd364f89a491fd2758ac1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d9dafb6f336564e2b773548a132e038baa314d45252e37aa244b7d5e0d76c4442137e6e52ec4e6f867b9e8ca1c30e0d129a3565837ebf806c915e4237f501dd"}' ========= master_lag: 0.76 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 13:28:43.662512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:28:43.662892) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464293052.432619-1351372135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004656 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:28:43.680643) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 13:28:43.681073) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 13:28:43.681399) ========= ========= Total master_lag: 0.85 =========