builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1464380495.17 results: success (0) buildid: 20160527103118 builduid: 7b36f1846bf44f9ea25bbc33f8dedbbb revision: fcedd1b3ef255d38681ab5e2745e45eaea926fb6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.171098) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.171770) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.172049) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.187217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.187566) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 13:21:35-- 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% 66.1M=0s 2016-05-27 13:21:35 (66.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071591 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.272796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.273110) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020686 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.322650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.323097) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fcedd1b3ef255d38681ab5e2745e45eaea926fb6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fcedd1b3ef255d38681ab5e2745e45eaea926fb6 --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=e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 13:21:35,826 truncating revision to first 12 chars 2016-05-27 13:21:35,826 Setting DEBUG logging. 2016-05-27 13:21:35,826 attempt 1/10 2016-05-27 13:21:35,826 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fcedd1b3ef25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 13:21:36,128 unpacking tar archive at: mozilla-inbound-fcedd1b3ef25/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621458 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.957710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.958013) ========= script_repo_revision: fcedd1b3ef255d38681ab5e2745e45eaea926fb6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.958399) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.958663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 13:21:35.968991) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-27 13:21:35.969319) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:21:36 INFO - MultiFileLogger online at 20160527 13:21:36 in /builds/slave/test 13:21:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:21:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:21:36 INFO - {'append_to_log': False, 13:21:36 INFO - 'base_work_dir': '/builds/slave/test', 13:21:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:21:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:21:36 INFO - 'branch': 'Mozilla-Inbound', 13:21:36 INFO - 'buildbot_json_path': 'buildprops.json', 13:21:36 INFO - 'config_files': ('talos/linux_config.py',), 13:21:36 INFO - 'default_actions': ('clobber', 13:21:36 INFO - 'read-buildbot-config', 13:21:36 INFO - 'download-and-extract', 13:21:36 INFO - 'populate-webroot', 13:21:36 INFO - 'create-virtualenv', 13:21:36 INFO - 'install', 13:21:36 INFO - 'run-tests'), 13:21:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:21:36 INFO - 'download_minidump_stackwalk': True, 13:21:36 INFO - 'download_symbols': 'ondemand', 13:21:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:21:36 INFO - 'tooltool.py': '/tools/tooltool.py', 13:21:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:21:36 INFO - '/tools/misc-python/virtualenv.py')}, 13:21:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:21:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:21:36 INFO - 'installer_path': 'installer.exe', 13:21:36 INFO - 'log_level': 'info', 13:21:36 INFO - 'log_name': 'talos', 13:21:36 INFO - 'log_to_console': True, 13:21:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:21:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:21:36 INFO - 'opt_config_files': (), 13:21:36 INFO - 'pip_index': False, 13:21:36 INFO - 'sps_profile': False, 13:21:36 INFO - 'sps_profile_interval': 0, 13:21:36 INFO - 'suite': 'dromaeojs', 13:21:36 INFO - 'system_bits': '32', 13:21:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:21:36 INFO - 'title': 'talos-linux64-ix-067', 13:21:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:21:36 INFO - 'use_talos_json': True, 13:21:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:21:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:21:36 INFO - 'work_dir': 'build'} 13:21:36 INFO - ##### 13:21:36 INFO - ##### Running clobber step. 13:21:36 INFO - ##### 13:21:36 INFO - Running pre-action listener: _resource_record_pre_action 13:21:36 INFO - Running main action method: clobber 13:21:36 INFO - rmtree: /builds/slave/test/build 13:21:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:21:37 INFO - Running post-action listener: _resource_record_post_action 13:21:37 INFO - ##### 13:21:37 INFO - ##### Finished clobber step (success) 13:21:37 INFO - ##### 13:21:37 INFO - ##### 13:21:37 INFO - ##### Running read-buildbot-config step. 13:21:37 INFO - ##### 13:21:37 INFO - Running pre-action listener: _resource_record_pre_action 13:21:37 INFO - Running main action method: read_buildbot_config 13:21:37 INFO - Using buildbot properties: 13:21:37 INFO - { 13:21:37 INFO - "project": "", 13:21:37 INFO - "product": "firefox", 13:21:37 INFO - "script_repo_revision": "production", 13:21:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:21:37 INFO - "repository": "", 13:21:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:21:37 INFO - "buildid": "20160527103118", 13:21:37 INFO - "pgo_build": "True", 13:21:37 INFO - "basedir": "/builds/slave/test", 13:21:37 INFO - "buildnumber": 1863, 13:21:37 INFO - "slavename": "talos-linux64-ix-067", 13:21:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:21:37 INFO - "platform": "ubuntu64_hw", 13:21:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:21:37 INFO - "branch": "mozilla-inbound", 13:21:37 INFO - "repo_path": "integration/mozilla-inbound", 13:21:37 INFO - "revision": "fcedd1b3ef255d38681ab5e2745e45eaea926fb6", 13:21:37 INFO - "stage_platform": "linux64-pgo", 13:21:37 INFO - "builduid": "7b36f1846bf44f9ea25bbc33f8dedbbb", 13:21:37 INFO - "slavebuilddir": "test" 13:21:37 INFO - } 13:21:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:21:37 INFO - Running post-action listener: _resource_record_post_action 13:21:37 INFO - ##### 13:21:37 INFO - ##### Finished read-buildbot-config step (success) 13:21:37 INFO - ##### 13:21:37 INFO - ##### 13:21:37 INFO - ##### Running download-and-extract step. 13:21:37 INFO - ##### 13:21:37 INFO - Running pre-action listener: _resource_record_pre_action 13:21:37 INFO - Running main action method: download_and_extract 13:21:37 INFO - mkdir: /builds/slave/test/build/tests 13:21:37 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:21:37 INFO - https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/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:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/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:21:41 INFO - Downloaded 1361 bytes. 13:21:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:21:41 INFO - Using the following test package requirements: 13:21:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:21:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:21:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:41 INFO - u'jsshell-linux-x86_64.zip'], 13:21:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:21:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:21:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:21:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:21:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:21:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:41 INFO - https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:21:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:21:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:21:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/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:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/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:21:44 INFO - Downloaded 24410098 bytes. 13:21:44 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:21:44 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:21:45 INFO - Return code: 0 13:21:45 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:21:45 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:21:45 INFO - https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/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:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/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:21:47 INFO - Downloaded 24410098 bytes. 13:21:47 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:21:47 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:21:49 INFO - Return code: 0 13:21:49 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:21:49 INFO - https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:21:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:21:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:21:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/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:21:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/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:21:50 INFO - Downloaded 10834034 bytes. 13:21:50 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:21:50 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:21:50 INFO - Return code: 0 13:21: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:21:50 INFO - https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:21:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:21:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:21:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/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:21:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvXU_L2STM2vd578MZdp1A/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:21:52 INFO - Downloaded 58827629 bytes. 13:21:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:21:52 INFO - mkdir: /builds/slave/test/properties 13:21:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:21:52 INFO - Writing to file /builds/slave/test/properties/build_url 13:21:52 INFO - Contents: 13:21:52 INFO - build_url:https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:21:52 INFO - Running post-action listener: _resource_record_post_action 13:21:52 INFO - Running post-action listener: set_extra_try_arguments 13:21:52 INFO - ##### 13:21:52 INFO - ##### Finished download-and-extract step (success) 13:21:52 INFO - ##### 13:21:52 INFO - ##### 13:21:52 INFO - ##### Running populate-webroot step. 13:21:52 INFO - ##### 13:21:52 INFO - Running pre-action listener: _resource_record_pre_action 13:21:52 INFO - Running main action method: populate_webroot 13:21:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:21:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:21:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:21:52 INFO - '--tppagecycles', 13:21:52 INFO - '7'], 13:21:52 INFO - 'tests': ['tsvgm']}}, 13:21:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:21:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:21:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:21:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:21:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:21:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:21:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:52 INFO - 'talos_options': ['--disable-e10s'], 13:21:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:52 INFO - 'talos_options': ['--disable-e10s'], 13:21:52 INFO - 'tests': ['damp', 'tps']}, 13:21:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:52 INFO - 'tests': ['damp', 'tps']}, 13:21:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:21:52 INFO - 'tests': ['dromaeo_dom']}, 13:21:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:21:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:21:52 INFO - 'tests': ['a11yr', 13:21:52 INFO - 'ts_paint', 13:21:52 INFO - 'tpaint', 13:21:52 INFO - 'sessionrestore', 13:21:52 INFO - 'sessionrestore_no_auto_restore', 13:21:52 INFO - 'tabpaint']}, 13:21:52 INFO - 'other-e10s': {'tests': ['a11yr', 13:21:52 INFO - 'ts_paint', 13:21:52 INFO - 'tpaint', 13:21:52 INFO - 'sessionrestore', 13:21:52 INFO - 'sessionrestore_no_auto_restore', 13:21:52 INFO - 'tabpaint']}, 13:21:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:21:52 INFO - 'ts_paint', 13:21:52 INFO - 'tpaint', 13:21:52 INFO - 'sessionrestore', 13:21:52 INFO - 'sessionrestore_no_auto_restore', 13:21:52 INFO - 'tabpaint']}, 13:21:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:21:52 INFO - 'ts_paint', 13:21:52 INFO - 'tpaint', 13:21:52 INFO - 'sessionrestore', 13:21:52 INFO - 'sessionrestore_no_auto_restore', 13:21:52 INFO - 'tabpaint']}, 13:21:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:21:52 INFO - 'tests': ['a11yr', 13:21:52 INFO - 'ts_paint', 13:21:52 INFO - 'tpaint', 13:21:52 INFO - 'sessionrestore', 13:21:52 INFO - 'sessionrestore_no_auto_restore', 13:21:52 INFO - 'tabpaint']}, 13:21:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:21:52 INFO - 'tests': ['a11yr', 13:21:52 INFO - 'ts_paint', 13:21:52 INFO - 'tpaint', 13:21:52 INFO - 'sessionrestore', 13:21:52 INFO - 'sessionrestore_no_auto_restore', 13:21:52 INFO - 'tabpaint']}, 13:21:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:21:52 INFO - 'tests': ['tsvgx', 13:21:52 INFO - 'tsvgr_opacity', 13:21:52 INFO - 'tart', 13:21:52 INFO - 'tscrollx', 13:21:52 INFO - 'cart']}, 13:21:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:21:52 INFO - 'tsvgr_opacity', 13:21:52 INFO - 'tart', 13:21:52 INFO - 'tscrollx', 13:21:52 INFO - 'cart']}, 13:21:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:52 INFO - 'talos_options': ['--disable-e10s'], 13:21:52 INFO - 'tests': ['tp5o']}, 13:21:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:52 INFO - 'tests': ['tp5o']}, 13:21:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:52 INFO - 'talos_options': ['--disable-e10s', 13:21:52 INFO - '--xperf_path', 13:21:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:52 INFO - 'tests': ['tp5n']}, 13:21:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:52 INFO - 'talos_options': ['--xperf_path', 13:21:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:52 INFO - 'tests': ['tp5n']}}, 13:21:52 INFO - 'talos.zip': {'path': '', 13:21:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:21:52 INFO - Running post-action listener: _resource_record_post_action 13:21:52 INFO - ##### 13:21:52 INFO - ##### Finished populate-webroot step (success) 13:21:52 INFO - ##### 13:21:52 INFO - ##### 13:21:52 INFO - ##### Running create-virtualenv step. 13:21:52 INFO - ##### 13:21:52 INFO - Running pre-action listener: _resource_record_pre_action 13:21:52 INFO - Running main action method: create_virtualenv 13:21:52 INFO - Creating virtualenv /builds/slave/test/build/venv 13:21:52 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:21:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:21:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:21:53 INFO - Using real prefix '/usr' 13:21:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:21:53 INFO - Installing distribute.............................................................................................................................................................................................done. 13:21:55 INFO - Installing pip.................done. 13:21:55 INFO - Return code: 0 13:21:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:21: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:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:55 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 0x7fa14cbc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a9c0>, '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 0x1e5b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', '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:21:55 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:21:55 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:21:55 INFO - Using env: {'DISPLAY': ':0', 13:21:55 INFO - 'HOME': '/home/cltbld', 13:21:55 INFO - 'LANG': 'en_US.UTF-8', 13:21:55 INFO - 'LANGUAGE': 'en_US:en', 13:21:55 INFO - 'LOGNAME': 'cltbld', 13:21:55 INFO - 'MAIL': '/var/mail/cltbld', 13:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:55 INFO - 'MOZ_NO_REMOTE': '1', 13:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:55 INFO - 'NO_EM_RESTART': '1', 13:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:55 INFO - 'PWD': '/builds/slave/test', 13:21:55 INFO - 'SHELL': '/bin/bash', 13:21:55 INFO - 'SHLVL': '1', 13:21:55 INFO - 'TERM': 'linux', 13:21:55 INFO - 'TMOUT': '86400', 13:21:55 INFO - 'USER': 'cltbld', 13:21:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', 13:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:55 INFO - '_': '/tools/buildbot/bin/python'} 13:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:55 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:21:55 INFO - Cleaning up... 13:21:55 INFO - Return code: 0 13:21:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:21: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:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:55 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 0x7fa14cbc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a9c0>, '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 0x1e5b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', '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:21:55 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:21:55 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:21:55 INFO - Using env: {'DISPLAY': ':0', 13:21:55 INFO - 'HOME': '/home/cltbld', 13:21:55 INFO - 'LANG': 'en_US.UTF-8', 13:21:55 INFO - 'LANGUAGE': 'en_US:en', 13:21:55 INFO - 'LOGNAME': 'cltbld', 13:21:55 INFO - 'MAIL': '/var/mail/cltbld', 13:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:55 INFO - 'MOZ_NO_REMOTE': '1', 13:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:55 INFO - 'NO_EM_RESTART': '1', 13:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:55 INFO - 'PWD': '/builds/slave/test', 13:21:55 INFO - 'SHELL': '/bin/bash', 13:21:55 INFO - 'SHLVL': '1', 13:21:55 INFO - 'TERM': 'linux', 13:21:55 INFO - 'TMOUT': '86400', 13:21:55 INFO - 'USER': 'cltbld', 13:21:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', 13:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:55 INFO - '_': '/tools/buildbot/bin/python'} 13:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:55 INFO - Downloading/unpacking psutil>=3.1.1 13:21:55 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:21:55 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:21:55 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:21:55 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:21:55 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:21:55 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:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:21:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:57 INFO - Installing collected packages: psutil 13:21:57 INFO - Running setup.py install for psutil 13:21:58 INFO - building 'psutil._psutil_linux' extension 13:21:58 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:21:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:21:58 INFO - building 'psutil._psutil_posix' extension 13:21:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:21:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:21:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:58 INFO - Successfully installed psutil 13:21:58 INFO - Cleaning up... 13:21:58 INFO - Return code: 0 13:21:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa14cbc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a9c0>, '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 0x1e5b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', '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:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:21:58 INFO - Using env: {'DISPLAY': ':0', 13:21:58 INFO - 'HOME': '/home/cltbld', 13:21:58 INFO - 'LANG': 'en_US.UTF-8', 13:21:58 INFO - 'LANGUAGE': 'en_US:en', 13:21:58 INFO - 'LOGNAME': 'cltbld', 13:21:58 INFO - 'MAIL': '/var/mail/cltbld', 13:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:58 INFO - 'MOZ_NO_REMOTE': '1', 13:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:58 INFO - 'NO_EM_RESTART': '1', 13:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:58 INFO - 'PWD': '/builds/slave/test', 13:21:58 INFO - 'SHELL': '/bin/bash', 13:21:58 INFO - 'SHLVL': '1', 13:21:58 INFO - 'TERM': 'linux', 13:21:58 INFO - 'TMOUT': '86400', 13:21:58 INFO - 'USER': 'cltbld', 13:21:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', 13:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:58 INFO - '_': '/tools/buildbot/bin/python'} 13:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:21:58 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:21:58 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:21:58 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:21:58 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:21:58 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:21:58 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:22:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:22:00 INFO - Installing collected packages: mozsystemmonitor 13:22:00 INFO - Running setup.py install for mozsystemmonitor 13:22:00 INFO - Successfully installed mozsystemmonitor 13:22:00 INFO - Cleaning up... 13:22:00 INFO - Return code: 0 13:22:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:22:00 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:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:00 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:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:00 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 0x7fa14cbc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a9c0>, '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 0x1e5b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', '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:22:00 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:22:00 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:22:00 INFO - Using env: {'DISPLAY': ':0', 13:22:00 INFO - 'HOME': '/home/cltbld', 13:22:00 INFO - 'LANG': 'en_US.UTF-8', 13:22:00 INFO - 'LANGUAGE': 'en_US:en', 13:22:00 INFO - 'LOGNAME': 'cltbld', 13:22:00 INFO - 'MAIL': '/var/mail/cltbld', 13:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:00 INFO - 'MOZ_NO_REMOTE': '1', 13:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:00 INFO - 'NO_EM_RESTART': '1', 13:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:00 INFO - 'PWD': '/builds/slave/test', 13:22:00 INFO - 'SHELL': '/bin/bash', 13:22:00 INFO - 'SHLVL': '1', 13:22:00 INFO - 'TERM': 'linux', 13:22:00 INFO - 'TMOUT': '86400', 13:22:00 INFO - 'USER': 'cltbld', 13:22:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', 13:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:00 INFO - '_': '/tools/buildbot/bin/python'} 13:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:00 INFO - Downloading/unpacking blobuploader==1.2.4 13:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:02 INFO - Downloading blobuploader-1.2.4.tar.gz 13:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:22:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:22:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:03 INFO - Downloading docopt-0.6.1.tar.gz 13:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:22:03 INFO - Installing collected packages: blobuploader, requests, docopt 13:22:03 INFO - Running setup.py install for blobuploader 13:22:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:22:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:22:03 INFO - Running setup.py install for requests 13:22:04 INFO - Running setup.py install for docopt 13:22:04 INFO - Successfully installed blobuploader requests docopt 13:22:04 INFO - Cleaning up... 13:22:04 INFO - Return code: 0 13:22:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:22: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:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22: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:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:04 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 0x7fa14cbc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a9c0>, '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 0x1e5b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', '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:22:04 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:22:04 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:22:04 INFO - Using env: {'DISPLAY': ':0', 13:22:04 INFO - 'HOME': '/home/cltbld', 13:22:04 INFO - 'LANG': 'en_US.UTF-8', 13:22:04 INFO - 'LANGUAGE': 'en_US:en', 13:22:04 INFO - 'LOGNAME': 'cltbld', 13:22:04 INFO - 'MAIL': '/var/mail/cltbld', 13:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:04 INFO - 'MOZ_NO_REMOTE': '1', 13:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:04 INFO - 'NO_EM_RESTART': '1', 13:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:04 INFO - 'PWD': '/builds/slave/test', 13:22:04 INFO - 'SHELL': '/bin/bash', 13:22:04 INFO - 'SHLVL': '1', 13:22:04 INFO - 'TERM': 'linux', 13:22:04 INFO - 'TMOUT': '86400', 13:22:04 INFO - 'USER': 'cltbld', 13:22:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', 13:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:04 INFO - '_': '/tools/buildbot/bin/python'} 13:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:22:04 INFO - Running setup.py (path:/tmp/pip-gFmpWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:22:04 INFO - Running setup.py (path:/tmp/pip-K9Xu7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:22:04 INFO - Running setup.py (path:/tmp/pip-b6Z0DX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:22:04 INFO - Running setup.py (path:/tmp/pip-XUsOJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:22:04 INFO - Running setup.py (path:/tmp/pip-Y4YojG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:22:04 INFO - Running setup.py (path:/tmp/pip-a2rhOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:22:04 INFO - Running setup.py (path:/tmp/pip-wFrXJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:22:04 INFO - Running setup.py (path:/tmp/pip-dggKjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:22:05 INFO - Running setup.py (path:/tmp/pip-3Baaqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:22:05 INFO - Running setup.py (path:/tmp/pip-NLD5Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:22:05 INFO - Running setup.py (path:/tmp/pip-Tny_9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:22:05 INFO - Running setup.py (path:/tmp/pip-lvvSVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:22:05 INFO - Running setup.py (path:/tmp/pip-mzdstX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:22:05 INFO - Running setup.py (path:/tmp/pip-RRX5ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:05 INFO - Running setup.py (path:/tmp/pip-2gO1q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:22:05 INFO - Running setup.py (path:/tmp/pip-9C2Cxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:22:05 INFO - Running setup.py (path:/tmp/pip-ldKw29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:22:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:22:05 INFO - Running setup.py install for manifestparser 13:22:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:22:05 INFO - Running setup.py install for mozcrash 13:22:05 INFO - Running setup.py install for mozdebug 13:22:05 INFO - Running setup.py install for mozdevice 13:22:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Running setup.py install for mozfile 13:22:06 INFO - Running setup.py install for mozhttpd 13:22:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Running setup.py install for mozinfo 13:22:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Running setup.py install for mozInstall 13:22:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Running setup.py install for mozleak 13:22:06 INFO - Running setup.py install for mozlog 13:22:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Running setup.py install for moznetwork 13:22:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Running setup.py install for mozprocess 13:22:06 INFO - Running setup.py install for mozprofile 13:22:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:22:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:22:07 INFO - Running setup.py install for mozrunner 13:22:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:22:07 INFO - Running setup.py install for mozscreenshot 13:22:07 INFO - Running setup.py install for moztest 13:22:07 INFO - Running setup.py install for mozversion 13:22:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:22:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:22:07 INFO - Cleaning up... 13:22:07 INFO - Return code: 0 13:22:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:07 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 0x7fa14cbc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a9c0>, '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 0x1e5b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', '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:22:07 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:22:07 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:22:07 INFO - Using env: {'DISPLAY': ':0', 13:22:07 INFO - 'HOME': '/home/cltbld', 13:22:07 INFO - 'LANG': 'en_US.UTF-8', 13:22:07 INFO - 'LANGUAGE': 'en_US:en', 13:22:07 INFO - 'LOGNAME': 'cltbld', 13:22:07 INFO - 'MAIL': '/var/mail/cltbld', 13:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:07 INFO - 'MOZ_NO_REMOTE': '1', 13:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:07 INFO - 'NO_EM_RESTART': '1', 13:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:07 INFO - 'PWD': '/builds/slave/test', 13:22:07 INFO - 'SHELL': '/bin/bash', 13:22:07 INFO - 'SHLVL': '1', 13:22:07 INFO - 'TERM': 'linux', 13:22:07 INFO - 'TMOUT': '86400', 13:22:07 INFO - 'USER': 'cltbld', 13:22:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', 13:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:07 INFO - '_': '/tools/buildbot/bin/python'} 13:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:22:07 INFO - Running setup.py (path:/tmp/pip-GWWeI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:22:07 INFO - Running setup.py (path:/tmp/pip-8LsMwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:22:07 INFO - Running setup.py (path:/tmp/pip-_fyNnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:22:07 INFO - Running setup.py (path:/tmp/pip-9f7PMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:22:07 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:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:22:07 INFO - Running setup.py (path:/tmp/pip-gyKGr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:22:08 INFO - Running setup.py (path:/tmp/pip-6eyyr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:22:08 INFO - Running setup.py (path:/tmp/pip-_661DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:22:08 INFO - Running setup.py (path:/tmp/pip-kq2xWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:22:08 INFO - Running setup.py (path:/tmp/pip-7JJ2Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:22:08 INFO - Running setup.py (path:/tmp/pip-Zwcna2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:22:08 INFO - Running setup.py (path:/tmp/pip-WwNmfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:22:08 INFO - Running setup.py (path:/tmp/pip-xaA8NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:22:08 INFO - Running setup.py (path:/tmp/pip-FZ2bij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:22:08 INFO - Running setup.py (path:/tmp/pip-03Bev4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:08 INFO - Running setup.py (path:/tmp/pip-uO2uXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:22:08 INFO - Running setup.py (path:/tmp/pip-FGlswD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:22:08 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:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:22:08 INFO - Running setup.py (path:/tmp/pip-KsztAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:22:08 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:22:08 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:22:08 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:22:08 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:22:08 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:22:08 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:22:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:22:08 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:22:08 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:22:08 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:22:08 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:22:08 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:22:08 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:22:10 INFO - Downloading blessings-1.6.tar.gz 13:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:22:10 INFO - Installing collected packages: blessings 13:22:10 INFO - Running setup.py install for blessings 13:22:10 INFO - Successfully installed blessings 13:22:10 INFO - Cleaning up... 13:22:11 INFO - Return code: 0 13:22:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:22:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:22:11 INFO - Reading from file tmpfile_stdout 13:22:11 INFO - Current package versions: 13:22:11 INFO - argparse == 1.2.1 13:22:11 INFO - blessings == 1.6 13:22:11 INFO - blobuploader == 1.2.4 13:22:11 INFO - docopt == 0.6.1 13:22:11 INFO - manifestparser == 1.1 13:22:11 INFO - mozInstall == 1.12 13:22:11 INFO - mozcrash == 0.17 13:22:11 INFO - mozdebug == 0.1 13:22:11 INFO - mozdevice == 0.48 13:22:11 INFO - mozfile == 1.2 13:22:11 INFO - mozhttpd == 0.7 13:22:11 INFO - mozinfo == 0.9 13:22:11 INFO - mozleak == 0.1 13:22:11 INFO - mozlog == 3.2 13:22:11 INFO - moznetwork == 0.27 13:22:11 INFO - mozprocess == 0.22 13:22:11 INFO - mozprofile == 0.28 13:22:11 INFO - mozrunner == 6.11 13:22:11 INFO - mozscreenshot == 0.1 13:22:11 INFO - mozsystemmonitor == 0.3 13:22:11 INFO - moztest == 0.7 13:22:11 INFO - mozversion == 1.4 13:22:11 INFO - psutil == 3.1.1 13:22:11 INFO - requests == 1.2.3 13:22:11 INFO - wsgiref == 0.1.2 13:22:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:11 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 0x7fa14cbc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a9c0>, '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 0x1e5b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', '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:22:11 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:22:11 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:22:11 INFO - Using env: {'DISPLAY': ':0', 13:22:11 INFO - 'HOME': '/home/cltbld', 13:22:11 INFO - 'LANG': 'en_US.UTF-8', 13:22:11 INFO - 'LANGUAGE': 'en_US:en', 13:22:11 INFO - 'LOGNAME': 'cltbld', 13:22:11 INFO - 'MAIL': '/var/mail/cltbld', 13:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:11 INFO - 'MOZ_NO_REMOTE': '1', 13:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:11 INFO - 'NO_EM_RESTART': '1', 13:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:11 INFO - 'PWD': '/builds/slave/test', 13:22:11 INFO - 'SHELL': '/bin/bash', 13:22:11 INFO - 'SHLVL': '1', 13:22:11 INFO - 'TERM': 'linux', 13:22:11 INFO - 'TMOUT': '86400', 13:22:11 INFO - 'USER': 'cltbld', 13:22:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', 13:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:11 INFO - '_': '/tools/buildbot/bin/python'} 13:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:11 INFO - Cleaning up... 13:22:11 INFO - Return code: 0 13:22:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:11 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 0x7fa14cbc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a9c0>, '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 0x1e5b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', '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:22:11 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:22:11 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:22:11 INFO - Using env: {'DISPLAY': ':0', 13:22:11 INFO - 'HOME': '/home/cltbld', 13:22:11 INFO - 'LANG': 'en_US.UTF-8', 13:22:11 INFO - 'LANGUAGE': 'en_US:en', 13:22:11 INFO - 'LOGNAME': 'cltbld', 13:22:11 INFO - 'MAIL': '/var/mail/cltbld', 13:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:11 INFO - 'MOZ_NO_REMOTE': '1', 13:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:11 INFO - 'NO_EM_RESTART': '1', 13:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:11 INFO - 'PWD': '/builds/slave/test', 13:22:11 INFO - 'SHELL': '/bin/bash', 13:22:11 INFO - 'SHLVL': '1', 13:22:11 INFO - 'TERM': 'linux', 13:22:11 INFO - 'TMOUT': '86400', 13:22:11 INFO - 'USER': 'cltbld', 13:22:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', 13:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:11 INFO - '_': '/tools/buildbot/bin/python'} 13:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:11 INFO - Downloading/unpacking jsonschema 13:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:22:13 INFO - Downloading/unpacking functools32 (from jsonschema) 13:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:13 INFO - Downloading functools32-3.2.3-2.tar.gz 13:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:22:13 INFO - warning: no files found matching '*.txt' 13:22:13 INFO - no previously-included directories found matching 'build' 13:22:13 INFO - no previously-included directories found matching 'dist' 13:22:13 INFO - no previously-included directories found matching '.git*' 13:22:13 INFO - Installing collected packages: jsonschema, functools32 13:22:13 INFO - Running setup.py install for functools32 13:22:13 INFO - warning: no files found matching '*.txt' 13:22:13 INFO - no previously-included directories found matching 'build' 13:22:13 INFO - no previously-included directories found matching 'dist' 13:22:13 INFO - no previously-included directories found matching '.git*' 13:22:13 INFO - Successfully installed jsonschema functools32 13:22:13 INFO - Cleaning up... 13:22:14 INFO - Return code: 0 13:22:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa14cbc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a9c0>, '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 0x1e5b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', '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:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:22:14 INFO - Using env: {'DISPLAY': ':0', 13:22:14 INFO - 'HOME': '/home/cltbld', 13:22:14 INFO - 'LANG': 'en_US.UTF-8', 13:22:14 INFO - 'LANGUAGE': 'en_US:en', 13:22:14 INFO - 'LOGNAME': 'cltbld', 13:22:14 INFO - 'MAIL': '/var/mail/cltbld', 13:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:14 INFO - 'MOZ_NO_REMOTE': '1', 13:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:14 INFO - 'NO_EM_RESTART': '1', 13:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:14 INFO - 'PWD': '/builds/slave/test', 13:22:14 INFO - 'SHELL': '/bin/bash', 13:22:14 INFO - 'SHLVL': '1', 13:22:14 INFO - 'TERM': 'linux', 13:22:14 INFO - 'TMOUT': '86400', 13:22:14 INFO - 'USER': 'cltbld', 13:22:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', 13:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:14 INFO - '_': '/tools/buildbot/bin/python'} 13:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:14 INFO - Downloading/unpacking flake8 13:22: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:22: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:22: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:22: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:22: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:22: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:22:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:22:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:22: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:22: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:22: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:22: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:22: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:22: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:22:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:22:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:22: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:22: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:22: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:22: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:22: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:22: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:22:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:22: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:22: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:22: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:22: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:22: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:22: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:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:22:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:22:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:22:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:22:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:22:16 INFO - no previously-included directories found matching 'docs/_build' 13:22:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:22:16 INFO - Running setup.py install for pep8 13:22:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:22:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:22:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:22:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:22:17 INFO - no previously-included directories found matching 'docs/_build' 13:22:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:22:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:22:17 INFO - Cleaning up... 13:22:17 INFO - Return code: 0 13:22:17 INFO - Running post-action listener: _resource_record_post_action 13:22:17 INFO - Running post-action listener: _start_resource_monitoring 13:22:17 INFO - Starting resource monitoring. 13:22:17 INFO - ##### 13:22:17 INFO - ##### Finished create-virtualenv step (success) 13:22:17 INFO - ##### 13:22:17 INFO - ##### 13:22:17 INFO - ##### Running install step. 13:22:17 INFO - ##### 13:22:17 INFO - Running pre-action listener: _resource_record_pre_action 13:22:17 INFO - Running main action method: install 13:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:22:17 INFO - Reading from file tmpfile_stdout 13:22:17 INFO - Detecting whether we're running mozinstall >=1.0... 13:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:22:17 INFO - Reading from file tmpfile_stdout 13:22:17 INFO - Output received: 13:22:17 INFO - Usage: mozinstall [options] installer 13:22:17 INFO - Options: 13:22:17 INFO - -h, --help show this help message and exit 13:22:17 INFO - -d DEST, --destination=DEST 13:22:17 INFO - Directory to install application into. [default: 13:22:17 INFO - "/builds/slave/test"] 13:22:17 INFO - --app=APP Application being installed. [default: firefox] 13:22:17 INFO - mkdir: /builds/slave/test/build/application 13:22:17 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:22:17 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:22:34 INFO - Reading from file tmpfile_stdout 13:22:34 INFO - Output received: 13:22:34 INFO - /builds/slave/test/build/application/firefox/firefox 13:22:34 INFO - Running post-action listener: _resource_record_post_action 13:22:34 INFO - ##### 13:22:34 INFO - ##### Finished install step (success) 13:22:34 INFO - ##### 13:22:34 INFO - ##### 13:22:34 INFO - ##### Running run-tests step. 13:22:34 INFO - ##### 13:22:34 INFO - Running pre-action listener: _resource_record_pre_action 13:22:34 INFO - Running main action method: run_tests 13:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:22:34 INFO - Python 2.7.3 13:22:34 INFO - Return code: 0 13:22:34 INFO - grabbing minidump binary from tooltool 13:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a9c0>, '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 0x1e5b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e5bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:22:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:22:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:22:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:22:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:22:34 INFO - Return code: 0 13:22:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:22:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:22:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:22:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:22:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:22:35 INFO - Return code: 0 13:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:22:35 INFO - Using env: {'DISPLAY': ':0', 13:22:35 INFO - 'HOME': '/home/cltbld', 13:22:35 INFO - 'LANG': 'en_US.UTF-8', 13:22:35 INFO - 'LANGUAGE': 'en_US:en', 13:22:35 INFO - 'LOGNAME': 'cltbld', 13:22:35 INFO - 'MAIL': '/var/mail/cltbld', 13:22:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:22:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:35 INFO - 'MOZ_NO_REMOTE': '1', 13:22:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:35 INFO - 'NO_EM_RESTART': '1', 13:22:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:35 INFO - 'PWD': '/builds/slave/test', 13:22:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:22:35 INFO - 'SHELL': '/bin/bash', 13:22:35 INFO - 'SHLVL': '1', 13:22:35 INFO - 'TERM': 'linux', 13:22:35 INFO - 'TMOUT': '86400', 13:22:35 INFO - 'USER': 'cltbld', 13:22:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889', 13:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:35 INFO - '_': '/tools/buildbot/bin/python'} 13:22:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:22:35 INFO - mozversion application_buildid: 20160527103118 13:22:35 INFO - mozversion application_changeset: fcedd1b3ef255d38681ab5e2745e45eaea926fb6 13:22:35 INFO - mozversion application_display_name: Nightly 13:22:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:22:35 INFO - mozversion application_name: Firefox 13:22:35 INFO - mozversion application_remotingname: firefox 13:22:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:22:35 INFO - mozversion application_vendor: Mozilla 13:22:35 INFO - mozversion application_version: 49.0a1 13:22:35 INFO - mozversion platform_buildid: 20160527103118 13:22:35 INFO - mozversion platform_changeset: fcedd1b3ef255d38681ab5e2745e45eaea926fb6 13:22:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:22:35 INFO - mozversion platform_version: 49.0a1 13:22:35 INFO - using testdate: 1464380555 13:22:35 INFO - actual date: 1464380555 13:22:35 INFO - starting webserver on 'localhost:38901' 13:22:35 INFO - SUITE-START | Running 2 tests 13:22:35 INFO - TEST-START | dromaeo_css 13:22:35 INFO - operating with platform_type : linux_ 13:22:35 INFO - Initialising browser for dromaeo_css test... 13:22:35 INFO - TEST-INFO | started process 2703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmF9o4A/profile http://localhost:38901/getInfo.html) 13:22:39 INFO - PROCESS | 2703 | __metrics Screen width/height:1600/1200 13:22:39 INFO - PROCESS | 2703 | colorDepth:24 13:22:39 INFO - PROCESS | 2703 | Browser inner width/height: 1024/697 13:22:39 INFO - PROCESS | 2703 | __metrics 13:22:40 ERROR - PROCESS | 2703 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:22:41 INFO - TEST-INFO | 2703: exit 0 13:22:41 INFO - Browser initialized. 13:22:41 INFO - Running cycle 1/1 for dromaeo_css test... 13:22:41 INFO - TEST-INFO | started process 2862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmF9o4A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:52 INFO - PROCESS | 2862 | RSS: Main: 155865088 13:22:52 INFO - PROCESS | 2862 | 13:23:43 INFO - PROCESS | 2862 | 1464380623961 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:25:51 INFO - PROCESS | 2862 | Cycle 1(1): loaded http://localhost:38901/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38901/tests/dromaeo/cssquery-ext.html) 13:25:52 INFO - PROCESS | 2862 | RSS: Main: 259899392 13:25:52 INFO - PROCESS | 2862 | 13:28:55 INFO - PROCESS | 2862 | Cycle 1(1): loaded http://localhost:38901/tests/dromaeo/cssquery-ext.html (next: http://localhost:38901/tests/dromaeo/cssquery-jquery.html) 13:28:55 INFO - PROCESS | 2862 | RSS: Main: 232464384 13:28:55 INFO - PROCESS | 2862 | 13:31:57 INFO - PROCESS | 2862 | Cycle 1(1): loaded http://localhost:38901/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38901/tests/dromaeo/cssquery-mootools.html) 13:31:58 INFO - PROCESS | 2862 | RSS: Main: 245334016 13:31:58 INFO - PROCESS | 2862 | 13:35:00 INFO - PROCESS | 2862 | Cycle 1(1): loaded http://localhost:38901/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38901/tests/dromaeo/cssquery-prototype.html) 13:35:01 INFO - PROCESS | 2862 | RSS: Main: 236748800 13:35:01 INFO - PROCESS | 2862 | 13:38:03 INFO - PROCESS | 2862 | Cycle 1(1): loaded http://localhost:38901/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38901/tests/dromaeo/cssquery-yui.html) 13:38:04 INFO - PROCESS | 2862 | RSS: Main: 219369472 13:38:04 INFO - PROCESS | 2862 | 13:41:07 INFO - PROCESS | 2862 | Cycle 1(1): loaded http://localhost:38901/tests/dromaeo/cssquery-yui.html (next: http://localhost:38901/tests/dromaeo/cssquery-dojo.html) 13:41:07 INFO - PROCESS | 2862 | RSS: Main: 313602048 13:41:07 INFO - PROCESS | 2862 | 13:41:07 INFO - PROCESS | 2862 | __start_tp_report 13:41:07 INFO - PROCESS | 2862 | _x_x_mozilla_page_load 13:41:07 INFO - PROCESS | 2862 | _x_x_mozilla_page_load_details 13:41:07 INFO - PROCESS | 2862 | |i|pagename|runs| 13:41:07 INFO - PROCESS | 2862 | |0;dojo.html;3151.243701511637;3158.8104713717194;3175.3966746318197;3185.3151572411925;3218.4850423932176;5381.569474442045;5418.566514678826;5435.864103397417;5558.916616250759;5577.972110139449;5435.402105768362;5437.918431223535;5440.863978400542;5506.146547285167;5532.834014979547;4784.617230621542;4881.438634557018;4884.145274576953;4887.804487820501;5075.467075957026;4964.329815474919;4974.900501989976;5001;5020.874478138057;5035.295058691786;4787.880302992418;4876.171050921352;4883.902321953541;4899.755012249373;4911.607071434295;4888.046830867982;4904.288878112689;4977.825776097856;4986.351774269322;5016.3980322361185;4780.354652121954;4943.505649435027;4951.158303088484;4958.504149585049;4981.153203955337;5375.220593013991;5439.4832490913695;5457.181422786574;5520;5536.086545719952;5929;5939.881202375928;5951.761929522814;5977.790777322816;5978.461938425563;5693.003724348264;5894.233749612523;5946.554008449383;5958.851028724316;5966.3138739045135;5546.55627549795;5599.992001439739;5639.182318563785;5648.717564121777;5651.2935883014625;6086.69136135733;6095.11517077047;6106.175666284995;6108.471341378493;6115.908261376083;5617.073182924853;5759.712014399263;5787.797427090031;5913.852153696106;5917.6745279010065;5910.615809972424;5919.467247947706;5927.110933359944;5964.642121472725;5988.820335389945;5855.648661080349;5891.46976772084;5910.172575839386;5912.852178695567;5913.379095195029;5681.4034526374135;5808.157817116579;5854.824355269348;5875.030619947661;5897.380775018647;4451.399061126771;4451.9554804451545;4461.308497182942;4461.732296062181;4494.910101797946;3942.1918506706056;3957.485526881487;3987.3620220764537;4020.8190631421658;4033.7378070425916;5403.513683768401;5457.61796674229;5527.447255274521;5528.778848846001;5573.60984731073;5937.287525496881;5960.791372301948;5967.791127310524;5968.761249550056;6025.548083893726;5602.887942241132;5604.747786349542;5612.214289999403;5613.578981576398;5614.157876318503;4975.477574854661;5065;5109.412417571953;5120.436751957282;5127.3847138343635;6172.783952561639;6181.505479561624;6193.721282542207;6196.442320191204;6198.504119670415;5788.565857560784;5989.101634754735;5995.910061348996;5996.8800623988145;5997.850053748692;6069.605475644069;6104.359042300672;6122.020476723703;6136.2636483622255;6151.415615516519;5818.679972601548;5825.94174058254;5845.064789633639;5847.883042339215;5854.648721076749;5683.460071293221;5866.2373891393845;5921.082232254007;5945.940540594712;5957.225560677084;5794.884102317846;5824.854378640568;5827;5836.824895253149;5888;5714.828555143353;5743.396943320891;5768.913466297925;5791.884162316815;5792.4497172768515;5481.3970463248215;5640.717964101696;5643.661380317194;5701.344345400166;5707.6290041147195;5843;5844.386339434468;5880.323762767336;5884.852878678067;5888.528917686661;5689.715514224189;5704.087346024616;5704.401037890962;5710.543156547549;5734.22587950638 13:41:07 INFO - PROCESS | 2862 | |1;ext.html;560.6187792301233;601.6690820048975;608.9543284253681;610.264631119501;624.9125122482852;33748.4937725934;36628.450573241425;36747.63252367476;36783.632163678354;44473.440819897514;43170;46819;47097.529024709744;47139;47188.52811471884;8673.522956237388;8891.73324800257;8892;8896.777580560472;8902.86645700315;8636.352273579476;8781.692640757576;8784.51685157316;8785.868211976825;8786.956065219696;8767.123287671213;8816.515091669955;8819.735407937773;8821.867671984925;8822.294216462667;8764.21122099011;8815.867761983576;8822.86765698515;8827.382083254175;8827.514486703261;8630.136986301382;8737.912620873774;8740.737777866674;8744.300455963572;8746.606402711894;42194.78902605467;42726.1454770906;42738;42739.786301068605;42746.572534274885;3575.3385623659447;3965.286248475273;4005.919881602352;4111.732737372061;4131.194417088669;32343.35313293721;32556.348873022405;32658.510122348183;32674;34025.31949360999;4224.936625950613;4330.39374487572;4365.890852728676;4496.2805951048;4515.887102822423;346487;346500;348759.99999999744;350319;351120;31283;58823.41176588265;58915;59109.70445147833;59133;37047.110053444536;37162;37205.81397092997;37249.627503724616;37254;14754.04098733579;14785.778213326808;14787.112773233424;14799.852001480063;14810.407583696531;11886.940565297291;11902.642920712393;11923.463444145034;11923.821142682868;11936;8258.876116858251;8322.791930201793;8344.123866993878;8419.284360829275;8435.072142064368;3195.3130077033084;3217.4530329843983;3225.1292151119064;3226.757993150476;3234.9838250808593;976.8974257702981;1042.3797840285017;1054.9367037977745;1115.8884111588777;1171.7715045566204;32643.18392040218;32877.34245315128;33098.17254568655;33236;33598.832005840304;1095.118429664128;1095.8411030400548;1133.1388145009853;1170.80096383615;1177.2818580665787;16835.579110522336;16957.236924338435;17125.743113853303;17155.590769535556;17348.566285842702;579236;582689;589645;590903;592248;60340;60862.695686521285;60906.69546652238;60931.39068609346;61030.38969610247;1296.7471343088007;1399.7410479061407;1409.9674929701048;1413.798271469243;1430.6351880270465;31801.36397272088;33197;33206.33587328192;33270.83364583259;33877;50088;50782.49217507778;50785.23822142597;50791.2381314288;50812.49187508078;417981;425679;426844;427296;427625;24910.252692419257;27173.320666983484;27588.44823103567;27752.167434976982;27866.16401507958;48765.51234487752;49232.75383623059;49740.253896190865;49797;50355.24467132923;40388.394174087996;40525.79737101296;40573.594264056985;41082.794586028074;41195.58804412038;40279.39580906348;40489.79755101206;40933.79533102315;41139.177216454904;41716.3742543856;40964.38553421642;41418.58581414268;41562.79218604009;42128.36807447952;42324.78837605792;34646.65353346535;36597.45103823498;36759;37231.627683722814;37322.813385932895;27503.44993100167;27646.861765691043;27885;28154.85922570374;28304.716952830207 13:41:07 INFO - PROCESS | 2862 | |2;jquery.html;389.5500696695317;398.9122393073523;400.24353970994815;403.44123389106096;422.4887885658353;14144.71710565788;17727.645447091065;17885.910570447162;19162.233510659575;19187;16521.091339976298;17480.47558573245;17517.299308027694;17913.462596122106;17962.37131700391;5539.972300138504;5636.15457681349;5713.514351280146;5717.571182161334;5721.227634269383;5535.833924982257;5653.519450846683;5654.293213348332;5665.575081868856;5672.886542269172;5550.361708403525;5562.360328562207;5622.550195984311;5633.126865335859;5636.887262254752;5599.188117722928;5604;5636.2954630671165;5640.238567793377;5645.5483561314995;4871.2206047032305;5079.187330027178;5082.2122571001555;5082.364704411949;5082.618803589746;22127;22573.097076116937;22777.886110569507;23049.654255186186;23110;2152.24671365021;2195.5828392605354;2370.466645004877;2677.759001689857;2864.799464037518;9441.480718560546;9674;10081.344712593658;10238.590456381737;14062.437502499888;1833.3399976008627;1845.64932662795;1865.5522674558144;1877.8028307027703;1943.5724140689167;80927.78365010672;83941;84556;85101;85880.57059714661;10188.694339169837;10313.896861031444;10474.633387831389;10840.295380800222;11000.119990400748;13490.325483725774;13665.248411337472;14724.411023558938;14848.628784280263;14928.626784330261;7982.08206056311;8168.591570421455;8238.176182381714;8267.586620668942;8409.663613455394;7870.4884182529095;8000.399970002273;8073.19268073188;8073.6366863491285;8130.837383252302;4627.768611569408;4788.11419887322;4790.784414701347;4837.105135549935;4865.9756701216265;1802.8467580255563;1883.9529011774541;1920.5486710622993;1963.3717210492791;1997.1711739628183;924.9815003699888;939.196986576481;954.8329042417549;1024.7233247023262;1076.3541874875168;17668;18464.538386540444;18652.533686657942;18917.05414729258;18984.122551561948;946.0586716217408;966.6471737815647;981.4945303168873;996.3225006995312;1040.245821779204;9909.900900991042;10466.215033872339;11188.319026189098;11512.36681982499;11688.532458701557;494844;494879;504314;523604;537950;68064.6596767013;96322;99539.50230248948;99771;99947;1075.1291453922347;1098.143448110459;1123.253036730565;1143.4797167288864;1149.9885001150049;17328;17544.912275438543;17588.91205543964;17693;18029.639407212046;26935.302264869213;34922.82538587291;36718.8164059178;40295;43878.561214387446;51724.74137629288;52254.738726306125;56586.15120773109;56989.71505142448;57269;8298.834023319621;8517.74446766598;8550.953359338386;8731.345149113715;8744.300455963381;12267.447964841782;12948.28784416866;13160.341982900625;13194.406251718889;13452.394642240926;11209.327440353605;11331;11489.425528723363;11614.6515604532;11626.88373116258;6122.816315510542;10445.276529372872;11528.365939873387;11564.47959841826;11802.763944720886;11305.26515776472;11706.180567360203;11814.527418903492;11945.522179113086;12088.15382923187;8226.136255693305;8325.750227493185;8412.789680258042;8452.112528184452;8458.703945361884;10829.458527073772;11566.768664626828;11622.360770157384;11625.302481851117;12019.4591243396 13:41:07 INFO - PROCESS | 2862 | |3;mootools.html;1290.348374071094;1514.7879296898436;1546.1264385622123;1722.7415887616855;1818.5817262029725;8456.238938495535;8866.645334186633;8876.689315873939;9101.180893719564;9130.726078217647;8899.421537600052;9094.86357704635;9143.268538516919;9145.039770824067;9145.634174633007;2099.086897199715;2347.5304939012267;2350.1421980976907;2371.9169829055986;2433.270018994295;2427.4295540547955;2431.1734010436535;2433.9513209735796;2434.0385547708643;2434.9513009739794;2373.8100951923893;2431.3070774829175;2432.4405386761055;2433.8174636902213;2433.9391515212083;2051.4973831411326;2328.7438381777906;2402.4954759500524;2406.3984003999;2406.6750988616486;2327.918522851692;2344.050659482912;2349.694539709844;2353.9293821185393;2385.403649087728;9099.63601455941;9103.27173826099;9163.266938644892;9174.220191283748;9182.954085229598;5283.682979021271;5397.109476936301;5407.918881216746;5416.458354164592;5418.539424148952;3094.6286445626442;3209.5506629071715;3273.6071671399586;3307.7849939753837;3329.184349834306;1098.4068602954394;1104.4312179227704;1110.0730889707104;1144.696655386315;1146.919715619907;12833;12913.612591622172;12950.935245323713;12951.222926624338;12968.092233543655;4717.337683004444;4824.300476430898;4873.610111191097;4874.5856602188505;4909.0672772173175;10875.78248435027;10895.346279223271;10908.50911708975;10928.672139835817;10935.28920620157;4822.373091498082;5360.142377219626;5360.410354860962;5364.463553644604;5364.758585863646;4779.569838714532;4890.095332363524;4890.682105663121;4942.8764280893265;4944.653874228769;4065.414488349546;4116.897077573025;4147.087640719037;4191.40726523919;4194.937075943863;1277.4756683136334;1289.5551034892947;1295.8250636164187;1301.5119330251157;1304.8795706976164;975.3952549419405;980.26969907418;988.9011098890197;995.8854731705802;1000.2648053680539;5910.408959104141;6060.909086363708;6103.267607887082;6105;6135.631862088289;433.6704104880314;442.38066706611;443.20666007845597;451.16309246347555;461.60071538119286;3808.4287356896134;3943.842246310173;3955.7626542407547;3961.069148750041;4011.2779699654343;11042.503087361089;11343.489542970587;11421.029212517029;11442.084633229488;11454.828177577343;11054.557817687364;11622.360770157722;11649.53401863933;11660.358680272666;11663.300201987908;8183.345332373396;8205.876911846328;8254.669813207525;8260.752177434806;8326.333893288522;5918.585699001201;5930.940690593039;5997.760089596367;6021.066734656135;6139.3246742857355;10463.476826158509;10495.632652857113;10577.576896924036;10590.735231619272;10607.94696026515;10470.633527826489;10771.19216058783;10837.241393102408;10857.511411986321;10877.728056798644;7102.573845569283;7944;8046.195380462141;8091.231333023354;8303.501789892625;8066.072401673882;8223.54770487629;8304.335653147855;8316.209960053786;8319;7562.924370756442;7636.160022397643;7809.609519524115;7828.13890472059;7886.211378862297;7570.507916985378;7707.34487568563;7717.614119294125;7811.218878112143;7864.4888082274465;6825.624590647562;6894.207166175754;6945.548539344926;6951.0616066830335;6958.338957799001;4822.565969062661;4950.356453661001;5094.159463688598;5110.693358398508;5122.462141475092;5109.131447653834;5137.768800404066;5157.484251574962;5182.611304152279;5253.422123566328 13:41:07 INFO - PROCESS | 2862 | |4;prototype.html;325.33469055780927;326.7092287863801;334.3697130908237;337.9932401351975;340.0902585583563;5274.4725527447235;5276.44344918249;5325.627206095575;5327.309708597153;5338.866528336794;5254.710990895499;5289.947100528993;5309.177077552986;5315.946840531594;5322.8137015204375;3931.4299426583198;4006.399040143973;4034.4755181826467;4038.6567141792984;4041.8585349512628;4092.570280120589;4129.4012368206595;4140.585941405865;4151.813168407429;4156.2934301168725;4097.959020409802;4102.0360215349365;4107.507099148092;4110.034141976633;4116.197341518405;3879.612038796112;3990.2618015667194;4059.817308221137;4065.2276067547073;4122.4640796696385;3540.274243780019;3589.910252243689;3594.155373487228;3595.644852621537;3603.351396748584;5068.645194836363;5080.872978175538;5082.390113186441;5082.500662304629;5095.85343297755;4563.954360456386;4716.599089077433;4717.575418212343;4734.484964811262;4742.122707299126;5482.342118945712;5492.423295553989;5503.587230957694;5519.365272993617;5525.502704756591;3985.60143985602;4026.1545075534173;4033.233685599727;4040.898977525556;4041.131156801302;5456.890862182774;5740.823131258082;5742.109972954198;5756.625819321731;5757.625754325997;4106.815193316308;4112.91774164515;4121.464209652726;4138.723701963908;4146.688998325078;4150.460440142762;4151.73013754105;4166;4173.7078404512;4178.791060446965;4615.261558150747;4741.5495527924795;4747.145513807548;4753.500882407367;4763.76181190939;5438.673679579238;5483.561315094783;5498.230247765316;5540.556755459554;5547.694876781816;1421.0389662266007;1438.6475313548249;1440.63984003999;1441.9279036048156;1442.4302400551724;886.5434301334818;926.4904302633524;926.6802952981211;930.0885132570119;942.6417961174847;5290.81482148123;5375.435579264121;5409.648372855751;5414.3232095988005;5428.375736790241;5688.658680479184;5736.196932429463;5737.91393129095;5749.3963133871175;5755.539556835443;5214;5357.919631205535;5370.570354371641;5388.784448622011;5420.891582168413;3009.337945651953;3011.885602327153;3030;3031.6362036555756;3040.78714489988;5887.8233652990475;5891.3814049525035;5901.291844978544;5915.201447804578;5962.07587823888;5621.213030175779;5881;5900.881982360329;5912.142739302777;5959.672218027963;5886.439398861509;5908.940910590839;5956.672383018976;5979.342272350038;5999.880002400015;5548.833534993795;5783.3638299787835;5802.620925420557;5805.82582522525;5815.82552523425;5650.208970744017;5668.631538949955;5668.773249069991;5709.34342550612;5725.942740572541;5838.708064596838;5923.437273459014;5925.140854576149;5946.851328716817;5954.635630868545;4019.4774679292673;4061.2080644275266;4079.306517891906;4098.590140985878;4100.835966561304;5749;5760.279965004374;5772.624779389326;5776;5783.652980821164;5271.578273738015;5605.934872374236;5656.773729050792;5656.971715141398;5658.830235092953;5571.60998730085;5584.46947539983;5596.916046259391;5615.326160860723;5616.5787565931905;5320.414754376938;5520.171974203901;5556.416576259435;5569.0229968360645;5574.944250557604;5198.766055527435;5507.284053073075;5571.164325351229;5580.972095139498;5615.915761263666;5433.157860531624;5452.291202143696;5454.9271276914515;5477.698726570077;5488.670679759227 13:41:07 INFO - PROCESS | 2862 | |5;yui.html;688.3116883116883;694.5693669924648;720.6612891940788;729.1614643160365;772.6484449575444;14520.78218826717;14809.481668141618;14977.251137443138;14984.925075374635;15004.32480538377;13322.200667959929;13342.66643333917;13364.599062028155;13365.665858353546;13391.12957657754;678.220046946011;787.7203592724586;810.5663470043528;816.2408959667507;825.84721826462;805.5448671500612;811.0308181722844;812.6464987730327;812.8618134917049;813.5281536708725;854.9786255343635;855.8673405622138;856.7815207122175;857.952812595307;858.2404571953834;701.0395757811805;727.8507905879283;728.9234630363815;827.3133299361516;845.2688424512783;608.6104892868568;608.7382425557008;608.9908651370233;609.2719200555338;629.0344321466526;13154.276514791683;13162.670933226746;13171.078024538287;13173.934130329288;13192.934035329858;13896.444142234299;13896.51362202318;13938;14115.64373295318;14263.85736142646;11889.108316876269;11957.820632690517;12042.096842736742;12105.515779368814;12301.630951071482;4300.526942036374;4335.7181783184;4345.50026746925;4357.934630980538;4365.170617582649;59735;60081.6995915022;60884;62386;62562.37437625611;10819.945900270606;10861.239713220157;10979.231453798317;11012.119030477703;11130.220884538005;19888.90055549742;20028.59942801136;20041.699374509393;20176.39470815878;20565.485862853548;7847.6468558914985;7858.2141785822105;8058.45428011673;8082.151374105634;8606.397552171413;4675.766211689402;4707.835225767081;4731.526847315241;4762.9761851191215;4872.171730805771;3450.6894379505966;3567.839447224881;3570.732195085379;3575.570931488238;3581.767185132958;653.5882394091786;658.1904257762978;660.9537332386783;674.4503229867643;682.6927882452916;589.9587228541627;635.7329921432917;670.4368330602317;672.3276723276723;676.9763058292937;8988.730338089868;10104.228573711544;10142.44216568081;10179.18566514677;10345.706786651668;600.8678090820013;656.7569999100268;677.2211956250352;713.3900515059653;739.5156172706886;4406.801693923781;4423.081712449828;4585.70192937458;4671.182543054952;4715.292706094114;68663.3133668657;71094.64452677703;71616.28383716097;71635.64182179056;72012.63993680103;61636.691816541526;62460.687696561225;62616;62662;63976.68011659912;53397.19904201362;53992.73003634957;54130;54415;54708.179377309374;8880.333974952033;8904.955475222841;8950.194482496607;8962.468665746252;9073.591688373906;33922.3215535683;37731.62268377281;38405.03987400226;38626.0343491415;38657.613423866525;48486.75756621194;48679.756601216766;48993.265101024226;49588.752056239486;50306;11805.881941180822;11987.34069626179;12150.635480935585;12216.511339546318;12328.32194229326;13332;13644;14073;14157.292135392983;14349.641258968191;12940.482380705043;13120.212787232796;13207;13248.602541923758;13436.731265374834;12442.307215625864;12803.871961280269;12861.228326300452;13167.868321316664;13289.734205316034;12707.87292127067;12715.745685086431;12761.553345632858;13062.412191451218;13308;10445.68662940113;10505.26463147603;10572.312799668305;10630.52162652667;10639.521221544894;10667.733306667085;11017.829538281298;11086.686704649099;11205.383703896365;11223.66329010131 13:41:07 INFO - PROCESS | 2862 | __end_tp_report 13:41:07 INFO - PROCESS | 2862 | __start_cc_report 13:41:07 INFO - PROCESS | 2862 | _x_x_mozilla_cycle_collect,903 13:41:07 INFO - PROCESS | 2862 | __end_cc_report 13:41:07 INFO - PROCESS | 2862 | __startTimestamp1464381667459__endTimestamp 13:41:07 INFO - PROCESS | 2862 | 13:41:07 INFO - PROCESS | 2862 | ------- Summary: start ------- 13:41:07 INFO - PROCESS | 2862 | Number of tests: 6 13:41:07 INFO - PROCESS | 2862 | 13:41:07 INFO - PROCESS | 2862 | [#0] dojo.html Cycles:165 Average:5474.57 Median:5693.00 stddev:649.89 (11.4%) stddev-sans-first:625.80 13:41:07 INFO - PROCESS | 2862 | Values: 3151.2 3158.8 3175.4 3185.3 3218.5 5381.6 5418.6 5435.9 5558.9 5578.0 5435.4 5437.9 5440.9 5506.1 5532.8 4784.6 4881.4 4884.1 4887.8 5075.5 4964.3 4974.9 5001.0 5020.9 5035.3 4787.9 4876.2 4883.9 4899.8 4911.6 4888.0 4904.3 4977.8 4986.4 5016.4 4780.4 4943.5 4951.2 4958.5 4981.2 5375.2 5439.5 5457.2 5520.0 5536.1 5929.0 5939.9 5951.8 5977.8 5978.5 5693.0 5894.2 5946.6 5958.9 5966.3 5546.6 5600.0 5639.2 5648.7 5651.3 6086.7 6095.1 6106.2 6108.5 6115.9 5617.1 5759.7 5787.8 5913.9 5917.7 5910.6 5919.5 5927.1 5964.6 5988.8 5855.6 5891.5 5910.2 5912.9 5913.4 5681.4 5808.2 5854.8 5875.0 5897.4 4451.4 4452.0 4461.3 4461.7 4494.9 3942.2 3957.5 3987.4 4020.8 4033.7 5403.5 5457.6 5527.4 5528.8 5573.6 5937.3 5960.8 5967.8 5968.8 6025.5 5602.9 5604.7 5612.2 5613.6 5614.2 4975.5 5065.0 5109.4 5120.4 5127.4 6172.8 6181.5 6193.7 6196.4 6198.5 5788.6 5989.1 5995.9 5996.9 5997.9 6069.6 6104.4 6122.0 6136.3 6151.4 5818.7 5825.9 5845.1 5847.9 5854.6 5683.5 5866.2 5921.1 5945.9 5957.2 5794.9 5824.9 5827.0 5836.8 5888.0 5714.8 5743.4 5768.9 5791.9 5792.4 5481.4 5640.7 5643.7 5701.3 5707.6 5843.0 5844.4 5880.3 5884.9 5888.5 5689.7 5704.1 5704.4 5710.5 5734.2 13:41:07 INFO - PROCESS | 2862 | 13:41:07 INFO - PROCESS | 2862 | [#1] ext.html Cycles:180 Average:60128.17 Median:22625.45 stddev:123661.76 (546.6%) stddev-sans-first:123927.79 13:41:07 INFO - PROCESS | 2862 | Values: 560.6 601.7 609.0 610.3 624.9 33748.5 36628.5 36747.6 36783.6 44473.4 43170.0 46819.0 47097.5 47139.0 47188.5 8673.5 8891.7 8892.0 8896.8 8902.9 8636.4 8781.7 8784.5 8785.9 8787.0 8767.1 8816.5 8819.7 8821.9 8822.3 8764.2 8815.9 8822.9 8827.4 8827.5 8630.1 8737.9 8740.7 8744.3 8746.6 42194.8 42726.1 42738.0 42739.8 42746.6 3575.3 3965.3 4005.9 4111.7 4131.2 32343.4 32556.3 32658.5 32674.0 34025.3 4224.9 4330.4 4365.9 4496.3 4515.9 346487.0 346500.0 348760.0 350319.0 351120.0 31283.0 58823.4 58915.0 59109.7 59133.0 37047.1 37162.0 37205.8 37249.6 37254.0 14754.0 14785.8 14787.1 14799.9 14810.4 11886.9 11902.6 11923.5 11923.8 11936.0 8258.9 8322.8 8344.1 8419.3 8435.1 3195.3 3217.5 3225.1 3226.8 3235.0 976.9 1042.4 1054.9 1115.9 1171.8 32643.2 32877.3 33098.2 33236.0 33598.8 1095.1 1095.8 1133.1 1170.8 1177.3 16835.6 16957.2 17125.7 17155.6 17348.6 579236.0 582689.0 589645.0 590903.0 592248.0 60340.0 60862.7 60906.7 60931.4 61030.4 1296.7 1399.7 1410.0 1413.8 1430.6 31801.4 33197.0 33206.3 33270.8 33877.0 50088.0 50782.5 50785.2 50791.2 50812.5 417981.0 425679.0 426844.0 427296.0 427625.0 24910.3 27173.3 27588.4 27752.2 27866.2 48765.5 49232.8 49740.3 49797.0 50355.2 40388.4 40525.8 40573.6 41082.8 41195.6 40279.4 40489.8 40933.8 41139.2 41716.4 40964.4 41418.6 41562.8 42128.4 42324.8 34646.7 36597.5 36759.0 37231.6 37322.8 27503.4 27646.9 27885.0 28154.9 28304.7 13:41:07 INFO - PROCESS | 2862 | 13:41:07 INFO - PROCESS | 2862 | [#2] jquery.html Cycles:180 Average:29258.77 Median:35820.82 stddev:84303.03 (235.3%) stddev-sans-first:84511.66 13:41:07 INFO - PROCESS | 2862 | Values: 389.6 398.9 400.2 403.4 422.5 14144.7 17727.6 17885.9 19162.2 19187.0 16521.1 17480.5 17517.3 17913.5 17962.4 5540.0 5636.2 5713.5 5717.6 5721.2 5535.8 5653.5 5654.3 5665.6 5672.9 5550.4 5562.4 5622.6 5633.1 5636.9 5599.2 5604.0 5636.3 5640.2 5645.5 4871.2 5079.2 5082.2 5082.4 5082.6 22127.0 22573.1 22777.9 23049.7 23110.0 2152.2 2195.6 2370.5 2677.8 2864.8 9441.5 9674.0 10081.3 10238.6 14062.4 1833.3 1845.6 1865.6 1877.8 1943.6 80927.8 83941.0 84556.0 85101.0 85880.6 10188.7 10313.9 10474.6 10840.3 11000.1 13490.3 13665.2 14724.4 14848.6 14928.6 7982.1 8168.6 8238.2 8267.6 8409.7 7870.5 8000.4 8073.2 8073.6 8130.8 4627.8 4788.1 4790.8 4837.1 4866.0 1802.8 1884.0 1920.5 1963.4 1997.2 925.0 939.2 954.8 1024.7 1076.4 17668.0 18464.5 18652.5 18917.1 18984.1 946.1 966.6 981.5 996.3 1040.2 9909.9 10466.2 11188.3 11512.4 11688.5 494844.0 494879.0 504314.0 523604.0 537950.0 68064.7 96322.0 99539.5 99771.0 99947.0 1075.1 1098.1 1123.3 1143.5 1150.0 17328.0 17544.9 17588.9 17693.0 18029.6 26935.3 34922.8 36718.8 40295.0 43878.6 51724.7 52254.7 56586.2 56989.7 57269.0 8298.8 8517.7 8551.0 8731.3 8744.3 12267.4 12948.3 13160.3 13194.4 13452.4 11209.3 11331.0 11489.4 11614.7 11626.9 6122.8 10445.3 11528.4 11564.5 11802.8 11305.3 11706.2 11814.5 11945.5 12088.2 8226.1 8325.8 8412.8 8452.1 8458.7 10829.5 11566.8 11622.4 11625.3 12019.5 13:41:07 INFO - PROCESS | 2862 | 13:41:07 INFO - PROCESS | 2862 | [#3] mootools.html Cycles:180 Average:5920.25 Median:2589.47 stddev:3469.80 (134.0%) stddev-sans-first:3462.09 13:41:07 INFO - PROCESS | 2862 | Values: 1290.3 1514.8 1546.1 1722.7 1818.6 8456.2 8866.6 8876.7 9101.2 9130.7 8899.4 9094.9 9143.3 9145.0 9145.6 2099.1 2347.5 2350.1 2371.9 2433.3 2427.4 2431.2 2434.0 2434.0 2435.0 2373.8 2431.3 2432.4 2433.8 2433.9 2051.5 2328.7 2402.5 2406.4 2406.7 2327.9 2344.1 2349.7 2353.9 2385.4 9099.6 9103.3 9163.3 9174.2 9183.0 5283.7 5397.1 5407.9 5416.5 5418.5 3094.6 3209.6 3273.6 3307.8 3329.2 1098.4 1104.4 1110.1 1144.7 1146.9 12833.0 12913.6 12950.9 12951.2 12968.1 4717.3 4824.3 4873.6 4874.6 4909.1 10875.8 10895.3 10908.5 10928.7 10935.3 4822.4 5360.1 5360.4 5364.5 5364.8 4779.6 4890.1 4890.7 4942.9 4944.7 4065.4 4116.9 4147.1 4191.4 4194.9 1277.5 1289.6 1295.8 1301.5 1304.9 975.4 980.3 988.9 995.9 1000.3 5910.4 6060.9 6103.3 6105.0 6135.6 433.7 442.4 443.2 451.2 461.6 3808.4 3943.8 3955.8 3961.1 4011.3 11042.5 11343.5 11421.0 11442.1 11454.8 11054.6 11622.4 11649.5 11660.4 11663.3 8183.3 8205.9 8254.7 8260.8 8326.3 5918.6 5930.9 5997.8 6021.1 6139.3 10463.5 10495.6 10577.6 10590.7 10607.9 10470.6 10771.2 10837.2 10857.5 10877.7 7102.6 7944.0 8046.2 8091.2 8303.5 8066.1 8223.5 8304.3 8316.2 8319.0 7562.9 7636.2 7809.6 7828.1 7886.2 7570.5 7707.3 7717.6 7811.2 7864.5 6825.6 6894.2 6945.5 6951.1 6958.3 4822.6 4950.4 5094.2 5110.7 5122.5 5109.1 5137.8 5157.5 5182.6 5253.4 13:41:07 INFO - PROCESS | 2862 | 13:41:07 INFO - PROCESS | 2862 | [#4] prototype.html Cycles:180 Average:4686.19 Median:5364.24 stddev:1386.49 (25.8%) stddev-sans-first:1351.19 13:41:07 INFO - PROCESS | 2862 | Values: 325.3 326.7 334.4 338.0 340.1 5274.5 5276.4 5325.6 5327.3 5338.9 5254.7 5289.9 5309.2 5315.9 5322.8 3931.4 4006.4 4034.5 4038.7 4041.9 4092.6 4129.4 4140.6 4151.8 4156.3 4098.0 4102.0 4107.5 4110.0 4116.2 3879.6 3990.3 4059.8 4065.2 4122.5 3540.3 3589.9 3594.2 3595.6 3603.4 5068.6 5080.9 5082.4 5082.5 5095.9 4564.0 4716.6 4717.6 4734.5 4742.1 5482.3 5492.4 5503.6 5519.4 5525.5 3985.6 4026.2 4033.2 4040.9 4041.1 5456.9 5740.8 5742.1 5756.6 5757.6 4106.8 4112.9 4121.5 4138.7 4146.7 4150.5 4151.7 4166.0 4173.7 4178.8 4615.3 4741.5 4747.1 4753.5 4763.8 5438.7 5483.6 5498.2 5540.6 5547.7 1421.0 1438.6 1440.6 1441.9 1442.4 886.5 926.5 926.7 930.1 942.6 5290.8 5375.4 5409.6 5414.3 5428.4 5688.7 5736.2 5737.9 5749.4 5755.5 5214.0 5357.9 5370.6 5388.8 5420.9 3009.3 3011.9 3030.0 3031.6 3040.8 5887.8 5891.4 5901.3 5915.2 5962.1 5621.2 5881.0 5900.9 5912.1 5959.7 5886.4 5908.9 5956.7 5979.3 5999.9 5548.8 5783.4 5802.6 5805.8 5815.8 5650.2 5668.6 5668.8 5709.3 5725.9 5838.7 5923.4 5925.1 5946.9 5954.6 4019.5 4061.2 4079.3 4098.6 4100.8 5749.0 5760.3 5772.6 5776.0 5783.7 5271.6 5605.9 5656.8 5657.0 5658.8 5571.6 5584.5 5596.9 5615.3 5616.6 5320.4 5520.2 5556.4 5569.0 5574.9 5198.8 5507.3 5571.2 5581.0 5615.9 5433.2 5452.3 5454.9 5477.7 5488.7 13:41:07 INFO - PROCESS | 2862 | 13:41:07 INFO - PROCESS | 2862 | [#5] yui.html Cycles:180 Average:15876.31 Median:4504.39 stddev:19231.86 (427.0%) stddev-sans-first:19251.99 13:41:07 INFO - PROCESS | 2862 | Values: 688.3 694.6 720.7 729.2 772.6 14520.8 14809.5 14977.3 14984.9 15004.3 13322.2 13342.7 13364.6 13365.7 13391.1 678.2 787.7 810.6 816.2 825.8 805.5 811.0 812.6 812.9 813.5 855.0 855.9 856.8 858.0 858.2 701.0 727.9 728.9 827.3 845.3 608.6 608.7 609.0 609.3 629.0 13154.3 13162.7 13171.1 13173.9 13192.9 13896.4 13896.5 13938.0 14115.6 14263.9 11889.1 11957.8 12042.1 12105.5 12301.6 4300.5 4335.7 4345.5 4357.9 4365.2 59735.0 60081.7 60884.0 62386.0 62562.4 10819.9 10861.2 10979.2 11012.1 11130.2 19888.9 20028.6 20041.7 20176.4 20565.5 7847.6 7858.2 8058.5 8082.2 8606.4 4675.8 4707.8 4731.5 4763.0 4872.2 3450.7 3567.8 3570.7 3575.6 3581.8 653.6 658.2 661.0 674.5 682.7 590.0 635.7 670.4 672.3 677.0 8988.7 10104.2 10142.4 10179.2 10345.7 600.9 656.8 677.2 713.4 739.5 4406.8 4423.1 4585.7 4671.2 4715.3 68663.3 71094.6 71616.3 71635.6 72012.6 61636.7 62460.7 62616.0 62662.0 63976.7 53397.2 53992.7 54130.0 54415.0 54708.2 8880.3 8905.0 8950.2 8962.5 9073.6 33922.3 37731.6 38405.0 38626.0 38657.6 48486.8 48679.8 48993.3 49588.8 50306.0 11805.9 11987.3 12150.6 12216.5 12328.3 13332.0 13644.0 14073.0 14157.3 14349.6 12940.5 13120.2 13207.0 13248.6 13436.7 12442.3 12803.9 12861.2 13167.9 13289.7 12707.9 12715.7 12761.6 13062.4 13308.0 10445.7 10505.3 10572.3 10630.5 10639.5 10667.7 11017.8 11086.7 11205.4 11223.7 13:41:07 INFO - PROCESS | 2862 | -------- Summary: end -------- 13:41:07 INFO - PROCESS | 2862 | 13:41:08 INFO - TEST-INFO | 2862: exit 0 13:41:08 INFO - TEST-OK | dromaeo_css | took 1112797ms 13:41:08 INFO - TEST-START | kraken 13:41:08 INFO - operating with platform_type : linux_ 13:41:08 INFO - Initialising browser for kraken test... 13:41:08 INFO - TEST-INFO | started process 3064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppWtjbe/profile http://localhost:38901/getInfo.html) 13:41:11 INFO - PROCESS | 3064 | __metrics Screen width/height:1600/1200 13:41:11 INFO - PROCESS | 3064 | colorDepth:24 13:41:11 INFO - PROCESS | 3064 | Browser inner width/height: 1024/697 13:41:11 INFO - PROCESS | 3064 | __metrics 13:41:12 ERROR - PROCESS | 3064 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:41:13 INFO - TEST-INFO | 3064: exit 0 13:41:13 INFO - Browser initialized. 13:41:13 INFO - Running cycle 1/1 for kraken test... 13:41:13 INFO - TEST-INFO | started process 3144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppWtjbe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:41:25 INFO - PROCESS | 3144 | RSS: Main: 155725824 13:41:25 INFO - PROCESS | 3144 | 13:41:27 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38901/tests/kraken/driver.html?testName=audio-beat-detection) 13:41:28 INFO - PROCESS | 3144 | RSS: Main: 213413888 13:41:28 INFO - PROCESS | 3144 | 13:41:31 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38901/tests/kraken/driver.html?testName=audio-dft) 13:41:31 INFO - PROCESS | 3144 | RSS: Main: 202272768 13:41:31 INFO - PROCESS | 3144 | 13:41:35 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38901/tests/kraken/driver.html?testName=audio-fft) 13:41:35 INFO - PROCESS | 3144 | RSS: Main: 268263424 13:41:35 INFO - PROCESS | 3144 | 13:41:37 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38901/tests/kraken/driver.html?testName=audio-oscillator) 13:41:38 INFO - PROCESS | 3144 | RSS: Main: 178622464 13:41:38 INFO - PROCESS | 3144 | 13:41:40 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38901/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:41:41 INFO - PROCESS | 3144 | RSS: Main: 184303616 13:41:41 INFO - PROCESS | 3144 | 13:41:44 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38901/tests/kraken/driver.html?testName=imaging-darkroom) 13:41:44 INFO - PROCESS | 3144 | RSS: Main: 217595904 13:41:44 INFO - PROCESS | 3144 | 13:41:48 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38901/tests/kraken/driver.html?testName=imaging-desaturate) 13:41:48 INFO - PROCESS | 3144 | RSS: Main: 219746304 13:41:48 INFO - PROCESS | 3144 | 13:41:51 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38901/tests/kraken/driver.html?testName=json-parse-financial) 13:41:52 INFO - PROCESS | 3144 | RSS: Main: 220262400 13:41:52 INFO - PROCESS | 3144 | 13:41:53 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38901/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:41:54 INFO - PROCESS | 3144 | RSS: Main: 208461824 13:41:54 INFO - PROCESS | 3144 | 13:41:56 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38901/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:41:56 INFO - PROCESS | 3144 | RSS: Main: 209481728 13:41:56 INFO - PROCESS | 3144 | 13:41:58 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38901/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:41:59 INFO - PROCESS | 3144 | RSS: Main: 215031808 13:41:59 INFO - PROCESS | 3144 | 13:42:01 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:42:02 INFO - PROCESS | 3144 | RSS: Main: 220917760 13:42:02 INFO - PROCESS | 3144 | 13:42:05 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:42:05 INFO - PROCESS | 3144 | RSS: Main: 220913664 13:42:05 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | Cycle 1(1): loaded http://localhost:38901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38901/tests/kraken/driver.html?testName=ai-astar) 13:42:07 INFO - PROCESS | 3144 | RSS: Main: 263217152 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | __start_tp_report 13:42:07 INFO - PROCESS | 3144 | _x_x_mozilla_page_load 13:42:07 INFO - PROCESS | 3144 | _x_x_mozilla_page_load_details 13:42:07 INFO - PROCESS | 3144 | |i|pagename|runs| 13:42:07 INFO - PROCESS | 3144 | |0;ai-astar;110;105;110;110;111;111;110;108;108;110 13:42:07 INFO - PROCESS | 3144 | |1;audio-beat-detection;151;127;125;174;129;125;154;128;160;123 13:42:07 INFO - PROCESS | 3144 | |2;audio-dft;162;164;163;162;162;162;163;163;163;160 13:42:07 INFO - PROCESS | 3144 | |3;audio-fft;74;74;75;121;76;77;74;74;116;74 13:42:07 INFO - PROCESS | 3144 | |4;audio-oscillator;84;84;113;83;84;83;118;83;83;123 13:42:07 INFO - PROCESS | 3144 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 13:42:07 INFO - PROCESS | 3144 | |6;imaging-darkroom;146;146;145;145;145;144;146;145;146;147 13:42:07 INFO - PROCESS | 3144 | |7;imaging-desaturate;95;94;96;94;94;95;95;95;95;95 13:42:07 INFO - PROCESS | 3144 | |8;json-parse-financial;53;53;53;52;54;53;55;53;54;61 13:42:07 INFO - PROCESS | 3144 | |9;json-stringify-tinderbox;61;61;62;62;62;60;62;61;60;62 13:42:07 INFO - PROCESS | 3144 | |10;stanford-crypto-aes;80;79;78;79;85;81;81;80;113;80 13:42:07 INFO - PROCESS | 3144 | |11;stanford-crypto-ccm;129;121;120;126;119;126;119;122;140;123 13:42:07 INFO - PROCESS | 3144 | |12;stanford-crypto-pbkdf2;160;161;162;163;159;162;164;161;158;164 13:42:07 INFO - PROCESS | 3144 | |13;stanford-crypto-sha256-iterative;63;68;65;61;64;64;63;62;61;59 13:42:07 INFO - PROCESS | 3144 | __end_tp_report 13:42:07 INFO - PROCESS | 3144 | __start_cc_report 13:42:07 INFO - PROCESS | 3144 | _x_x_mozilla_cycle_collect,1642 13:42:07 INFO - PROCESS | 3144 | __end_cc_report 13:42:07 INFO - PROCESS | 3144 | __startTimestamp1464381727818__endTimestamp 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | ------- Summary: start ------- 13:42:07 INFO - PROCESS | 3144 | Number of tests: 14 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.83 (1.7%) stddev-sans-first:1.92 13:42:07 INFO - PROCESS | 3144 | Values: 110.0 105.0 110.0 110.0 111.0 111.0 110.0 108.0 108.0 110.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:140.00 stddev:18.39 (13.1%) stddev-sans-first:19.04 13:42:07 INFO - PROCESS | 3144 | Values: 151.0 127.0 125.0 174.0 129.0 125.0 154.0 128.0 160.0 123.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 13:42:07 INFO - PROCESS | 3144 | Values: 162.0 164.0 163.0 162.0 162.0 162.0 163.0 163.0 163.0 160.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#3] audio-fft Cycles:10 Average:83.50 Median:74.00 stddev:18.51 (25.0%) stddev-sans-first:19.31 13:42:07 INFO - PROCESS | 3144 | Values: 74.0 74.0 75.0 121.0 76.0 77.0 74.0 74.0 116.0 74.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:83.00 stddev:16.87 (20.3%) stddev-sans-first:17.52 13:42:07 INFO - PROCESS | 3144 | Values: 84.0 84.0 113.0 83.0 84.0 83.0 118.0 83.0 83.0 123.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:42:07 INFO - PROCESS | 3144 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 13:42:07 INFO - PROCESS | 3144 | Values: 146.0 146.0 145.0 145.0 145.0 144.0 146.0 145.0 146.0 147.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 13:42:07 INFO - PROCESS | 3144 | Values: 95.0 94.0 96.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.50 stddev:2.56 (4.8%) stddev-sans-first:2.68 13:42:07 INFO - PROCESS | 3144 | Values: 53.0 53.0 53.0 52.0 54.0 53.0 55.0 53.0 54.0 61.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 13:42:07 INFO - PROCESS | 3144 | Values: 61.0 61.0 62.0 62.0 62.0 60.0 62.0 61.0 60.0 62.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:80.00 stddev:10.50 (13.1%) stddev-sans-first:11.06 13:42:07 INFO - PROCESS | 3144 | Values: 80.0 79.0 78.0 79.0 85.0 81.0 81.0 80.0 113.0 80.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:124.50 stddev:6.38 (5.1%) stddev-sans-first:6.56 13:42:07 INFO - PROCESS | 3144 | Values: 129.0 121.0 120.0 126.0 119.0 126.0 119.0 122.0 140.0 123.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:2.01 (1.2%) stddev-sans-first:2.07 13:42:07 INFO - PROCESS | 3144 | Values: 160.0 161.0 162.0 163.0 159.0 162.0 164.0 161.0 158.0 164.0 13:42:07 INFO - PROCESS | 3144 | 13:42:07 INFO - PROCESS | 3144 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:2.49 (3.9%) stddev-sans-first:2.65 13:42:07 INFO - PROCESS | 3144 | Values: 63.0 68.0 65.0 61.0 64.0 64.0 63.0 62.0 61.0 59.0 13:42:07 INFO - PROCESS | 3144 | -------- Summary: end -------- 13:42:07 INFO - PROCESS | 3144 | 13:42:08 INFO - TEST-INFO | 3144: exit 0 13:42:08 INFO - TEST-OK | kraken | took 60669ms 13:42:08 INFO - SUITE-END | took 1173s 13:42:08 INFO - Completed test suite (00:19:33) 13:42:08 INFO - javascript benchmark 13:42:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.243701511637, 3158.8104713717194, 3175.3966746318197, 3185.3151572411925, 3218.4850423932176, 5381.569474442045, 5418.566514678826, 5435.864103397417, 5558.916616250759, 5577.972110139449, 5435.402105768362, 5437.918431223535, 5440.863978400542, 5506.146547285167, 5532.834014979547, 4784.617230621542, 4881.438634557018, 4884.145274576953, 4887.804487820501, 5075.467075957026, 4964.329815474919, 4974.900501989976, 5001.0, 5020.874478138057, 5035.295058691786, 4787.880302992418, 4876.171050921352, 4883.902321953541, 4899.755012249373, 4911.607071434295, 4888.046830867982, 4904.288878112689, 4977.825776097856, 4986.351774269322, 5016.3980322361185, 4780.354652121954, 4943.505649435027, 4951.158303088484, 4958.504149585049, 4981.153203955337, 5375.220593013991, 5439.4832490913695, 5457.181422786574, 5520.0, 5536.086545719952, 5929.0, 5939.881202375928, 5951.761929522814, 5977.790777322816, 5978.461938425563, 5693.003724348264, 5894.233749612523, 5946.554008449383, 5958.851028724316, 5966.3138739045135, 5546.55627549795, 5599.992001439739, 5639.182318563785, 5648.717564121777, 5651.2935883014625, 6086.69136135733, 6095.11517077047, 6106.175666284995, 6108.471341378493, 6115.908261376083, 5617.073182924853, 5759.712014399263, 5787.797427090031, 5913.852153696106, 5917.6745279010065, 5910.615809972424, 5919.467247947706, 5927.110933359944, 5964.642121472725, 5988.820335389945, 5855.648661080349, 5891.46976772084, 5910.172575839386, 5912.852178695567, 5913.379095195029, 5681.4034526374135, 5808.157817116579, 5854.824355269348, 5875.030619947661, 5897.380775018647, 4451.399061126771, 4451.9554804451545, 4461.308497182942, 4461.732296062181, 4494.910101797946, 3942.1918506706056, 3957.485526881487, 3987.3620220764537, 4020.8190631421658, 4033.7378070425916, 5403.513683768401, 5457.61796674229, 5527.447255274521, 5528.778848846001, 5573.60984731073, 5937.287525496881, 5960.791372301948, 5967.791127310524, 5968.761249550056, 6025.548083893726, 5602.887942241132, 5604.747786349542, 5612.214289999403, 5613.578981576398, 5614.157876318503, 4975.477574854661, 5065.0, 5109.412417571953, 5120.436751957282, 5127.3847138343635, 6172.783952561639, 6181.505479561624, 6193.721282542207, 6196.442320191204, 6198.504119670415, 5788.565857560784, 5989.101634754735, 5995.910061348996, 5996.8800623988145, 5997.850053748692, 6069.605475644069, 6104.359042300672, 6122.020476723703, 6136.2636483622255, 6151.415615516519, 5818.679972601548, 5825.94174058254, 5845.064789633639, 5847.883042339215, 5854.648721076749, 5683.460071293221, 5866.2373891393845, 5921.082232254007, 5945.940540594712, 5957.225560677084, 5794.884102317846, 5824.854378640568, 5827.0, 5836.824895253149, 5888.0, 5714.828555143353, 5743.396943320891, 5768.913466297925, 5791.884162316815, 5792.4497172768515, 5481.3970463248215, 5640.717964101696, 5643.661380317194, 5701.344345400166, 5707.6290041147195, 5843.0, 5844.386339434468, 5880.323762767336, 5884.852878678067, 5888.528917686661, 5689.715514224189, 5704.087346024616, 5704.401037890962, 5710.543156547549, 5734.22587950638], "value": 5429.113937629156, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.6187792301233, 601.6690820048975, 608.9543284253681, 610.264631119501, 624.9125122482852, 33748.4937725934, 36628.450573241425, 36747.63252367476, 36783.632163678354, 44473.440819897514, 43170.0, 46819.0, 47097.529024709744, 47139.0, 47188.52811471884, 8673.522956237388, 8891.73324800257, 8892.0, 8896.777580560472, 8902.86645700315, 8636.352273579476, 8781.692640757576, 8784.51685157316, 8785.868211976825, 8786.956065219696, 8767.123287671213, 8816.515091669955, 8819.735407937773, 8821.867671984925, 8822.294216462667, 8764.21122099011, 8815.867761983576, 8822.86765698515, 8827.382083254175, 8827.514486703261, 8630.136986301382, 8737.912620873774, 8740.737777866674, 8744.300455963572, 8746.606402711894, 42194.78902605467, 42726.1454770906, 42738.0, 42739.786301068605, 42746.572534274885, 3575.3385623659447, 3965.286248475273, 4005.919881602352, 4111.732737372061, 4131.194417088669, 32343.35313293721, 32556.348873022405, 32658.510122348183, 32674.0, 34025.31949360999, 4224.936625950613, 4330.39374487572, 4365.890852728676, 4496.2805951048, 4515.887102822423, 346487.0, 346500.0, 348759.99999999744, 350319.0, 351120.0, 31283.0, 58823.41176588265, 58915.0, 59109.70445147833, 59133.0, 37047.110053444536, 37162.0, 37205.81397092997, 37249.627503724616, 37254.0, 14754.04098733579, 14785.778213326808, 14787.112773233424, 14799.852001480063, 14810.407583696531, 11886.940565297291, 11902.642920712393, 11923.463444145034, 11923.821142682868, 11936.0, 8258.876116858251, 8322.791930201793, 8344.123866993878, 8419.284360829275, 8435.072142064368, 3195.3130077033084, 3217.4530329843983, 3225.1292151119064, 3226.757993150476, 3234.9838250808593, 976.8974257702981, 1042.3797840285017, 1054.9367037977745, 1115.8884111588777, 1171.7715045566204, 32643.18392040218, 32877.34245315128, 33098.17254568655, 33236.0, 33598.832005840304, 1095.118429664128, 1095.8411030400548, 1133.1388145009853, 1170.80096383615, 1177.2818580665787, 16835.579110522336, 16957.236924338435, 17125.743113853303, 17155.590769535556, 17348.566285842702, 579236.0, 582689.0, 589645.0, 590903.0, 592248.0, 60340.0, 60862.695686521285, 60906.69546652238, 60931.39068609346, 61030.38969610247, 1296.7471343088007, 1399.7410479061407, 1409.9674929701048, 1413.798271469243, 1430.6351880270465, 31801.36397272088, 33197.0, 33206.33587328192, 33270.83364583259, 33877.0, 50088.0, 50782.49217507778, 50785.23822142597, 50791.2381314288, 50812.49187508078, 417981.0, 425679.0, 426844.0, 427296.0, 427625.0, 24910.252692419257, 27173.320666983484, 27588.44823103567, 27752.167434976982, 27866.16401507958, 48765.51234487752, 49232.75383623059, 49740.253896190865, 49797.0, 50355.24467132923, 40388.394174087996, 40525.79737101296, 40573.594264056985, 41082.794586028074, 41195.58804412038, 40279.39580906348, 40489.79755101206, 40933.79533102315, 41139.177216454904, 41716.3742543856, 40964.38553421642, 41418.58581414268, 41562.79218604009, 42128.36807447952, 42324.78837605792, 34646.65353346535, 36597.45103823498, 36759.0, 37231.627683722814, 37322.813385932895, 27503.44993100167, 27646.861765691043, 27885.0, 28154.85922570374, 28304.716952830207], "value": 18966.838288708605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.5500696695317, 398.9122393073523, 400.24353970994815, 403.44123389106096, 422.4887885658353, 14144.71710565788, 17727.645447091065, 17885.910570447162, 19162.233510659575, 19187.0, 16521.091339976298, 17480.47558573245, 17517.299308027694, 17913.462596122106, 17962.37131700391, 5539.972300138504, 5636.15457681349, 5713.514351280146, 5717.571182161334, 5721.227634269383, 5535.833924982257, 5653.519450846683, 5654.293213348332, 5665.575081868856, 5672.886542269172, 5550.361708403525, 5562.360328562207, 5622.550195984311, 5633.126865335859, 5636.887262254752, 5599.188117722928, 5604.0, 5636.2954630671165, 5640.238567793377, 5645.5483561314995, 4871.2206047032305, 5079.187330027178, 5082.2122571001555, 5082.364704411949, 5082.618803589746, 22127.0, 22573.097076116937, 22777.886110569507, 23049.654255186186, 23110.0, 2152.24671365021, 2195.5828392605354, 2370.466645004877, 2677.759001689857, 2864.799464037518, 9441.480718560546, 9674.0, 10081.344712593658, 10238.590456381737, 14062.437502499888, 1833.3399976008627, 1845.64932662795, 1865.5522674558144, 1877.8028307027703, 1943.5724140689167, 80927.78365010672, 83941.0, 84556.0, 85101.0, 85880.57059714661, 10188.694339169837, 10313.896861031444, 10474.633387831389, 10840.295380800222, 11000.119990400748, 13490.325483725774, 13665.248411337472, 14724.411023558938, 14848.628784280263, 14928.626784330261, 7982.08206056311, 8168.591570421455, 8238.176182381714, 8267.586620668942, 8409.663613455394, 7870.4884182529095, 8000.399970002273, 8073.19268073188, 8073.6366863491285, 8130.837383252302, 4627.768611569408, 4788.11419887322, 4790.784414701347, 4837.105135549935, 4865.9756701216265, 1802.8467580255563, 1883.9529011774541, 1920.5486710622993, 1963.3717210492791, 1997.1711739628183, 924.9815003699888, 939.196986576481, 954.8329042417549, 1024.7233247023262, 1076.3541874875168, 17668.0, 18464.538386540444, 18652.533686657942, 18917.05414729258, 18984.122551561948, 946.0586716217408, 966.6471737815647, 981.4945303168873, 996.3225006995312, 1040.245821779204, 9909.900900991042, 10466.215033872339, 11188.319026189098, 11512.36681982499, 11688.532458701557, 494844.0, 494879.0, 504314.0, 523604.0, 537950.0, 68064.6596767013, 96322.0, 99539.50230248948, 99771.0, 99947.0, 1075.1291453922347, 1098.143448110459, 1123.253036730565, 1143.4797167288864, 1149.9885001150049, 17328.0, 17544.912275438543, 17588.91205543964, 17693.0, 18029.639407212046, 26935.302264869213, 34922.82538587291, 36718.8164059178, 40295.0, 43878.561214387446, 51724.74137629288, 52254.738726306125, 56586.15120773109, 56989.71505142448, 57269.0, 8298.834023319621, 8517.74446766598, 8550.953359338386, 8731.345149113715, 8744.300455963381, 12267.447964841782, 12948.28784416866, 13160.341982900625, 13194.406251718889, 13452.394642240926, 11209.327440353605, 11331.0, 11489.425528723363, 11614.6515604532, 11626.88373116258, 6122.816315510542, 10445.276529372872, 11528.365939873387, 11564.47959841826, 11802.763944720886, 11305.26515776472, 11706.180567360203, 11814.527418903492, 11945.522179113086, 12088.15382923187, 8226.136255693305, 8325.750227493185, 8412.789680258042, 8452.112528184452, 8458.703945361884, 10829.458527073772, 11566.768664626828, 11622.360770157384, 11625.302481851117, 12019.4591243396], "value": 9071.910120486233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.348374071094, 1514.7879296898436, 1546.1264385622123, 1722.7415887616855, 1818.5817262029725, 8456.238938495535, 8866.645334186633, 8876.689315873939, 9101.180893719564, 9130.726078217647, 8899.421537600052, 9094.86357704635, 9143.268538516919, 9145.039770824067, 9145.634174633007, 2099.086897199715, 2347.5304939012267, 2350.1421980976907, 2371.9169829055986, 2433.270018994295, 2427.4295540547955, 2431.1734010436535, 2433.9513209735796, 2434.0385547708643, 2434.9513009739794, 2373.8100951923893, 2431.3070774829175, 2432.4405386761055, 2433.8174636902213, 2433.9391515212083, 2051.4973831411326, 2328.7438381777906, 2402.4954759500524, 2406.3984003999, 2406.6750988616486, 2327.918522851692, 2344.050659482912, 2349.694539709844, 2353.9293821185393, 2385.403649087728, 9099.63601455941, 9103.27173826099, 9163.266938644892, 9174.220191283748, 9182.954085229598, 5283.682979021271, 5397.109476936301, 5407.918881216746, 5416.458354164592, 5418.539424148952, 3094.6286445626442, 3209.5506629071715, 3273.6071671399586, 3307.7849939753837, 3329.184349834306, 1098.4068602954394, 1104.4312179227704, 1110.0730889707104, 1144.696655386315, 1146.919715619907, 12833.0, 12913.612591622172, 12950.935245323713, 12951.222926624338, 12968.092233543655, 4717.337683004444, 4824.300476430898, 4873.610111191097, 4874.5856602188505, 4909.0672772173175, 10875.78248435027, 10895.346279223271, 10908.50911708975, 10928.672139835817, 10935.28920620157, 4822.373091498082, 5360.142377219626, 5360.410354860962, 5364.463553644604, 5364.758585863646, 4779.569838714532, 4890.095332363524, 4890.682105663121, 4942.8764280893265, 4944.653874228769, 4065.414488349546, 4116.897077573025, 4147.087640719037, 4191.40726523919, 4194.937075943863, 1277.4756683136334, 1289.5551034892947, 1295.8250636164187, 1301.5119330251157, 1304.8795706976164, 975.3952549419405, 980.26969907418, 988.9011098890197, 995.8854731705802, 1000.2648053680539, 5910.408959104141, 6060.909086363708, 6103.267607887082, 6105.0, 6135.631862088289, 433.6704104880314, 442.38066706611, 443.20666007845597, 451.16309246347555, 461.60071538119286, 3808.4287356896134, 3943.842246310173, 3955.7626542407547, 3961.069148750041, 4011.2779699654343, 11042.503087361089, 11343.489542970587, 11421.029212517029, 11442.084633229488, 11454.828177577343, 11054.557817687364, 11622.360770157722, 11649.53401863933, 11660.358680272666, 11663.300201987908, 8183.345332373396, 8205.876911846328, 8254.669813207525, 8260.752177434806, 8326.333893288522, 5918.585699001201, 5930.940690593039, 5997.760089596367, 6021.066734656135, 6139.3246742857355, 10463.476826158509, 10495.632652857113, 10577.576896924036, 10590.735231619272, 10607.94696026515, 10470.633527826489, 10771.19216058783, 10837.241393102408, 10857.511411986321, 10877.728056798644, 7102.573845569283, 7944.0, 8046.195380462141, 8091.231333023354, 8303.501789892625, 8066.072401673882, 8223.54770487629, 8304.335653147855, 8316.209960053786, 8319.0, 7562.924370756442, 7636.160022397643, 7809.609519524115, 7828.13890472059, 7886.211378862297, 7570.507916985378, 7707.34487568563, 7717.614119294125, 7811.218878112143, 7864.4888082274465, 6825.624590647562, 6894.207166175754, 6945.548539344926, 6951.0616066830335, 6958.338957799001, 4822.565969062661, 4950.356453661001, 5094.159463688598, 5110.693358398508, 5122.462141475092, 5109.131447653834, 5137.768800404066, 5157.484251574962, 5182.611304152279, 5253.422123566328], "value": 4623.374005877418, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.33469055780927, 326.7092287863801, 334.3697130908237, 337.9932401351975, 340.0902585583563, 5274.4725527447235, 5276.44344918249, 5325.627206095575, 5327.309708597153, 5338.866528336794, 5254.710990895499, 5289.947100528993, 5309.177077552986, 5315.946840531594, 5322.8137015204375, 3931.4299426583198, 4006.399040143973, 4034.4755181826467, 4038.6567141792984, 4041.8585349512628, 4092.570280120589, 4129.4012368206595, 4140.585941405865, 4151.813168407429, 4156.2934301168725, 4097.959020409802, 4102.0360215349365, 4107.507099148092, 4110.034141976633, 4116.197341518405, 3879.612038796112, 3990.2618015667194, 4059.817308221137, 4065.2276067547073, 4122.4640796696385, 3540.274243780019, 3589.910252243689, 3594.155373487228, 3595.644852621537, 3603.351396748584, 5068.645194836363, 5080.872978175538, 5082.390113186441, 5082.500662304629, 5095.85343297755, 4563.954360456386, 4716.599089077433, 4717.575418212343, 4734.484964811262, 4742.122707299126, 5482.342118945712, 5492.423295553989, 5503.587230957694, 5519.365272993617, 5525.502704756591, 3985.60143985602, 4026.1545075534173, 4033.233685599727, 4040.898977525556, 4041.131156801302, 5456.890862182774, 5740.823131258082, 5742.109972954198, 5756.625819321731, 5757.625754325997, 4106.815193316308, 4112.91774164515, 4121.464209652726, 4138.723701963908, 4146.688998325078, 4150.460440142762, 4151.73013754105, 4166.0, 4173.7078404512, 4178.791060446965, 4615.261558150747, 4741.5495527924795, 4747.145513807548, 4753.500882407367, 4763.76181190939, 5438.673679579238, 5483.561315094783, 5498.230247765316, 5540.556755459554, 5547.694876781816, 1421.0389662266007, 1438.6475313548249, 1440.63984003999, 1441.9279036048156, 1442.4302400551724, 886.5434301334818, 926.4904302633524, 926.6802952981211, 930.0885132570119, 942.6417961174847, 5290.81482148123, 5375.435579264121, 5409.648372855751, 5414.3232095988005, 5428.375736790241, 5688.658680479184, 5736.196932429463, 5737.91393129095, 5749.3963133871175, 5755.539556835443, 5214.0, 5357.919631205535, 5370.570354371641, 5388.784448622011, 5420.891582168413, 3009.337945651953, 3011.885602327153, 3030.0, 3031.6362036555756, 3040.78714489988, 5887.8233652990475, 5891.3814049525035, 5901.291844978544, 5915.201447804578, 5962.07587823888, 5621.213030175779, 5881.0, 5900.881982360329, 5912.142739302777, 5959.672218027963, 5886.439398861509, 5908.940910590839, 5956.672383018976, 5979.342272350038, 5999.880002400015, 5548.833534993795, 5783.3638299787835, 5802.620925420557, 5805.82582522525, 5815.82552523425, 5650.208970744017, 5668.631538949955, 5668.773249069991, 5709.34342550612, 5725.942740572541, 5838.708064596838, 5923.437273459014, 5925.140854576149, 5946.851328716817, 5954.635630868545, 4019.4774679292673, 4061.2080644275266, 4079.306517891906, 4098.590140985878, 4100.835966561304, 5749.0, 5760.279965004374, 5772.624779389326, 5776.0, 5783.652980821164, 5271.578273738015, 5605.934872374236, 5656.773729050792, 5656.971715141398, 5658.830235092953, 5571.60998730085, 5584.46947539983, 5596.916046259391, 5615.326160860723, 5616.5787565931905, 5320.414754376938, 5520.171974203901, 5556.416576259435, 5569.0229968360645, 5574.944250557604, 5198.766055527435, 5507.284053073075, 5571.164325351229, 5580.972095139498, 5615.915761263666, 5433.157860531624, 5452.291202143696, 5454.9271276914515, 5477.698726570077, 5488.670679759227], "value": 4243.23485817876, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.3116883116883, 694.5693669924648, 720.6612891940788, 729.1614643160365, 772.6484449575444, 14520.78218826717, 14809.481668141618, 14977.251137443138, 14984.925075374635, 15004.32480538377, 13322.200667959929, 13342.66643333917, 13364.599062028155, 13365.665858353546, 13391.12957657754, 678.220046946011, 787.7203592724586, 810.5663470043528, 816.2408959667507, 825.84721826462, 805.5448671500612, 811.0308181722844, 812.6464987730327, 812.8618134917049, 813.5281536708725, 854.9786255343635, 855.8673405622138, 856.7815207122175, 857.952812595307, 858.2404571953834, 701.0395757811805, 727.8507905879283, 728.9234630363815, 827.3133299361516, 845.2688424512783, 608.6104892868568, 608.7382425557008, 608.9908651370233, 609.2719200555338, 629.0344321466526, 13154.276514791683, 13162.670933226746, 13171.078024538287, 13173.934130329288, 13192.934035329858, 13896.444142234299, 13896.51362202318, 13938.0, 14115.64373295318, 14263.85736142646, 11889.108316876269, 11957.820632690517, 12042.096842736742, 12105.515779368814, 12301.630951071482, 4300.526942036374, 4335.7181783184, 4345.50026746925, 4357.934630980538, 4365.170617582649, 59735.0, 60081.6995915022, 60884.0, 62386.0, 62562.37437625611, 10819.945900270606, 10861.239713220157, 10979.231453798317, 11012.119030477703, 11130.220884538005, 19888.90055549742, 20028.59942801136, 20041.699374509393, 20176.39470815878, 20565.485862853548, 7847.6468558914985, 7858.2141785822105, 8058.45428011673, 8082.151374105634, 8606.397552171413, 4675.766211689402, 4707.835225767081, 4731.526847315241, 4762.9761851191215, 4872.171730805771, 3450.6894379505966, 3567.839447224881, 3570.732195085379, 3575.570931488238, 3581.767185132958, 653.5882394091786, 658.1904257762978, 660.9537332386783, 674.4503229867643, 682.6927882452916, 589.9587228541627, 635.7329921432917, 670.4368330602317, 672.3276723276723, 676.9763058292937, 8988.730338089868, 10104.228573711544, 10142.44216568081, 10179.18566514677, 10345.706786651668, 600.8678090820013, 656.7569999100268, 677.2211956250352, 713.3900515059653, 739.5156172706886, 4406.801693923781, 4423.081712449828, 4585.70192937458, 4671.182543054952, 4715.292706094114, 68663.3133668657, 71094.64452677703, 71616.28383716097, 71635.64182179056, 72012.63993680103, 61636.691816541526, 62460.687696561225, 62616.0, 62662.0, 63976.68011659912, 53397.19904201362, 53992.73003634957, 54130.0, 54415.0, 54708.179377309374, 8880.333974952033, 8904.955475222841, 8950.194482496607, 8962.468665746252, 9073.591688373906, 33922.3215535683, 37731.62268377281, 38405.03987400226, 38626.0343491415, 38657.613423866525, 48486.75756621194, 48679.756601216766, 48993.265101024226, 49588.752056239486, 50306.0, 11805.881941180822, 11987.34069626179, 12150.635480935585, 12216.511339546318, 12328.32194229326, 13332.0, 13644.0, 14073.0, 14157.292135392983, 14349.641258968191, 12940.482380705043, 13120.212787232796, 13207.0, 13248.602541923758, 13436.731265374834, 12442.307215625864, 12803.871961280269, 12861.228326300452, 13167.868321316664, 13289.734205316034, 12707.87292127067, 12715.745685086431, 12761.553345632858, 13062.412191451218, 13308.0, 10445.68662940113, 10505.26463147603, 10572.312799668305, 10630.52162652667, 10639.521221544894, 10667.733306667085, 11017.829538281298, 11086.686704649099, 11205.383703896365, 11223.66329010131], "value": 6890.092284910433, "unit": "score"}], "name": "dromaeo_css", "value": 7083.115539223304, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 110.0, 111.0, 111.0, 110.0, 108.0, 108.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 125.0, 174.0, 129.0, 125.0, 154.0, 128.0, 160.0, 123.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 162.0, 162.0, 162.0, 163.0, 163.0, 163.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 121.0, 76.0, 77.0, 74.0, 74.0, 116.0, 74.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 83.0, 84.0, 83.0, 118.0, 83.0, 83.0, 123.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 144.0, 146.0, 145.0, 146.0, 147.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 52.0, 54.0, 53.0, 55.0, 53.0, 54.0, 61.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 60.0, 62.0, 61.0, 60.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 79.0, 85.0, 81.0, 81.0, 80.0, 113.0, 80.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 121.0, 120.0, 126.0, 119.0, 126.0, 119.0, 122.0, 140.0, 123.0], "value": 124.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 163.0, 159.0, 162.0, 164.0, 161.0, 158.0, 164.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 65.0, 61.0, 64.0, 64.0, 63.0, 62.0, 61.0, 59.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1493.8999999999999, "alertThreshold": 2.0}]} 13:42:09 INFO - Return code: 0 13:42:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:42:09 ERROR - # TBPL SUCCESS # 13:42:09 INFO - Running post-action listener: _resource_record_post_action 13:42:09 INFO - ##### 13:42:09 INFO - ##### Finished run-tests step (success) 13:42:09 INFO - ##### 13:42:09 INFO - Running post-run listener: _resource_record_post_run 13:42:09 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542576640; Read time: 4; Write time: 388476 13:42:09 INFO - TinderboxPrint: CPU usage
13.1% 13:42:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 13:42:09 INFO - TinderboxPrint: I/O write bytes / time
542,576,640 / 388,476 13:42:09 INFO - TinderboxPrint: CPU idle
8,258.9 (86.9%) 13:42:09 INFO - TinderboxPrint: CPU user
1,203.4 (12.7%) 13:42:09 INFO - TinderboxPrint: Swap in / out
0 / 0 13:42:09 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247332864; Read time: 0; Write time: 215348 13:42:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295243776; Read time: 4; Write time: 173128 13:42:09 INFO - Running post-run listener: _upload_blobber_files 13:42:09 INFO - Blob upload gear active. 13:42:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:42:09 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:42:09 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:42:09 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:42:10 INFO - (blobuploader) - INFO - Open directory for files ... 13:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:42:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:14 INFO - (blobuploader) - INFO - Done attempting. 13:42:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:42:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:42:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:15 INFO - (blobuploader) - INFO - Done attempting. 13:42:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:42:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:42:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:16 INFO - (blobuploader) - INFO - Done attempting. 13:42:16 INFO - (blobuploader) - INFO - Iteration through files over. 13:42:16 INFO - Return code: 0 13:42:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:42:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:42:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87b0e1cda6815d37981772b242d94e86d8e8d25e41a7b408f98722405d7a2156b3b039de9eb4a20ab53270d71f7ff16456e7c65f50ac93f5efb6fa737a5fe004", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a8577446a27fa8079a3bc3209af0be5389286aea775884c2166a991cd87ce2fcb94b0e83df204505789cf0b9013c37792200e699aef49467458b86914c7cf26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e560f2c614c6cebf3608ee9bd97dbae403ecac18b552da85623f4c0e290993d544f9826ed48800e53c642b38fdf2b89f03b608afc7b46000ca631b704219071"} 13:42:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:42:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:42:16 INFO - Contents: 13:42:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87b0e1cda6815d37981772b242d94e86d8e8d25e41a7b408f98722405d7a2156b3b039de9eb4a20ab53270d71f7ff16456e7c65f50ac93f5efb6fa737a5fe004", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a8577446a27fa8079a3bc3209af0be5389286aea775884c2166a991cd87ce2fcb94b0e83df204505789cf0b9013c37792200e699aef49467458b86914c7cf26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e560f2c614c6cebf3608ee9bd97dbae403ecac18b552da85623f4c0e290993d544f9826ed48800e53c642b38fdf2b89f03b608afc7b46000ca631b704219071"} 13:42:16 INFO - Running post-run listener: copy_logs_to_upload_dir 13:42:16 INFO - Copying logs to upload dir... 13:42:16 INFO - mkdir: /builds/slave/test/build/upload/logs 13:42:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.679436 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-27 13:42:15.661085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 13:42:15.668181) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87b0e1cda6815d37981772b242d94e86d8e8d25e41a7b408f98722405d7a2156b3b039de9eb4a20ab53270d71f7ff16456e7c65f50ac93f5efb6fa737a5fe004", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a8577446a27fa8079a3bc3209af0be5389286aea775884c2166a991cd87ce2fcb94b0e83df204505789cf0b9013c37792200e699aef49467458b86914c7cf26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e560f2c614c6cebf3608ee9bd97dbae403ecac18b552da85623f4c0e290993d544f9826ed48800e53c642b38fdf2b89f03b608afc7b46000ca631b704219071"} build_url:https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/AvXU_L2STM2vd578MZdp1A/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/Mozilla-Inbound/sha512/87b0e1cda6815d37981772b242d94e86d8e8d25e41a7b408f98722405d7a2156b3b039de9eb4a20ab53270d71f7ff16456e7c65f50ac93f5efb6fa737a5fe004", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a8577446a27fa8079a3bc3209af0be5389286aea775884c2166a991cd87ce2fcb94b0e83df204505789cf0b9013c37792200e699aef49467458b86914c7cf26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e560f2c614c6cebf3608ee9bd97dbae403ecac18b552da85623f4c0e290993d544f9826ed48800e53c642b38fdf2b89f03b608afc7b46000ca631b704219071"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 13:42:15.695990) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:42:15.696333) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464380268.472134-1331075889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 13:42:15.777427) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 13:42:15.780846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 13:42:15.781204) ========= ========= Total master_lag: 0.16 =========