builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1458290944.85 results: success (0) buildid: 20160318010713 builduid: 6e2c762eee0d4dc9919f1176df3300e8 revision: 7f5889e82e92a43294a9e0d5e393e38bbf59632d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.847470) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.847943) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.848233) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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-1458290944.610111-1320820025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006270 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.870710) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.871011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.884470) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.884738) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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-1458290944.610111-1320820025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.934008) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.934313) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.934692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:04.934980) ========= 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-1458290944.610111-1320820025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 01:49:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.6M=0s 2016-03-18 01:49:05 (67.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093840 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:05.041324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:05.041633) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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-1458290944.610111-1320820025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022484 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:05.090966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:05.091363) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7f5889e82e92a43294a9e0d5e393e38bbf59632d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7f5889e82e92a43294a9e0d5e393e38bbf59632d --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-1458290944.610111-1320820025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 01:49:05,585 truncating revision to first 12 chars 2016-03-18 01:49:05,585 Setting DEBUG logging. 2016-03-18 01:49:05,585 attempt 1/10 2016-03-18 01:49:05,585 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7f5889e82e92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 01:49:05,828 unpacking tar archive at: fx-team-7f5889e82e92/testing/mozharness/ program finished with exit code 0 elapsedTime=0.519736 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:05.625135) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:05.625469) ========= echo 7f5889e82e92a43294a9e0d5e393e38bbf59632d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7f5889e82e92a43294a9e0d5e393e38bbf59632d'] 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-1458290944.610111-1320820025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7f5889e82e92a43294a9e0d5e393e38bbf59632d program finished with exit code 0 elapsedTime=0.003647 script_repo_revision: '7f5889e82e92a43294a9e0d5e393e38bbf59632d' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:05.673651) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:05.673981) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 01:49:05.683660) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-18 01:49:05.683947) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:49:06 INFO - MultiFileLogger online at 20160318 01:49:06 in /builds/slave/test 01:49:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:49:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:49:06 INFO - {'append_to_log': False, 01:49:06 INFO - 'base_work_dir': '/builds/slave/test', 01:49:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:49:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:49:06 INFO - 'branch': 'Fx-Team-Non-PGO', 01:49:06 INFO - 'buildbot_json_path': 'buildprops.json', 01:49:06 INFO - 'config_files': ('talos/linux_config.py',), 01:49:06 INFO - 'default_actions': ('clobber', 01:49:06 INFO - 'read-buildbot-config', 01:49:06 INFO - 'download-and-extract', 01:49:06 INFO - 'populate-webroot', 01:49:06 INFO - 'create-virtualenv', 01:49:06 INFO - 'install', 01:49:06 INFO - 'run-tests'), 01:49:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:49:06 INFO - 'download_minidump_stackwalk': True, 01:49:06 INFO - 'download_symbols': 'ondemand', 01:49:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:49:06 INFO - 'tooltool.py': '/tools/tooltool.py', 01:49:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:49:06 INFO - '/tools/misc-python/virtualenv.py')}, 01:49:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:49:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:49:06 INFO - 'installer_path': 'installer.exe', 01:49:06 INFO - 'log_level': 'info', 01:49:06 INFO - 'log_name': 'talos', 01:49:06 INFO - 'log_to_console': True, 01:49:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:49:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:49:06 INFO - 'opt_config_files': (), 01:49:06 INFO - 'pip_index': False, 01:49:06 INFO - 'sps_profile': False, 01:49:06 INFO - 'sps_profile_interval': 0, 01:49:06 INFO - 'suite': 'dromaeojs', 01:49:06 INFO - 'system_bits': '32', 01:49:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:49:06 INFO - 'title': 'talos-linux64-ix-067', 01:49:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:49:06 INFO - 'use_talos_json': True, 01:49:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:49:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:49:06 INFO - 'work_dir': 'build'} 01:49:06 INFO - ##### 01:49:06 INFO - ##### Running clobber step. 01:49:06 INFO - ##### 01:49:06 INFO - Running pre-action listener: _resource_record_pre_action 01:49:06 INFO - Running main action method: clobber 01:49:06 INFO - rmtree: /builds/slave/test/build 01:49:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:49:06 INFO - Running post-action listener: _resource_record_post_action 01:49:06 INFO - ##### 01:49:06 INFO - ##### Running read-buildbot-config step. 01:49:06 INFO - ##### 01:49:06 INFO - Running pre-action listener: _resource_record_pre_action 01:49:06 INFO - Running main action method: read_buildbot_config 01:49:06 INFO - Using buildbot properties: 01:49:06 INFO - { 01:49:06 INFO - "project": "", 01:49:06 INFO - "product": "firefox", 01:49:06 INFO - "script_repo_revision": "production", 01:49:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:49:06 INFO - "repository": "", 01:49:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:49:06 INFO - "buildid": "20160318010713", 01:49:06 INFO - "pgo_build": "False", 01:49:06 INFO - "basedir": "/builds/slave/test", 01:49:06 INFO - "buildnumber": 1470, 01:49:06 INFO - "slavename": "talos-linux64-ix-067", 01:49:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:49:06 INFO - "platform": "ubuntu64_hw", 01:49:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:49:06 INFO - "branch": "fx-team", 01:49:06 INFO - "repo_path": "integration/fx-team", 01:49:06 INFO - "revision": "7f5889e82e92a43294a9e0d5e393e38bbf59632d", 01:49:06 INFO - "stage_platform": "linux64", 01:49:06 INFO - "builduid": "6e2c762eee0d4dc9919f1176df3300e8", 01:49:06 INFO - "slavebuilddir": "test" 01:49:06 INFO - } 01:49:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 01:49:06 INFO - Running post-action listener: _resource_record_post_action 01:49:06 INFO - ##### 01:49:06 INFO - ##### Running download-and-extract step. 01:49:06 INFO - ##### 01:49:06 INFO - Running pre-action listener: _resource_record_pre_action 01:49:06 INFO - Running main action method: download_and_extract 01:49:06 INFO - mkdir: /builds/slave/test/build/tests 01:49:06 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')]} 01:49:06 INFO - https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:49:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:49:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:49:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:49:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:49:07 INFO - Downloaded 1361 bytes. 01:49:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:49:07 INFO - Using the following test package requirements: 01:49:07 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:49:07 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:49:07 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:49:07 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:07 INFO - u'jsshell-linux-x86_64.zip'], 01:49:07 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:49:07 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:49:07 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:49:07 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:49:07 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:49:07 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:49:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:49: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')]} 01:49:07 INFO - https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:49:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:49:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:49:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:49:08 INFO - Downloaded 22008997 bytes. 01:49:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:49:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:49:09 INFO - Return code: 0 01:49:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:09 INFO - https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:49:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:49:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:49:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:49:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:49:10 INFO - Downloaded 22008997 bytes. 01:49:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:49:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:49:12 INFO - Return code: 0 01:49:12 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')]} 01:49:12 INFO - https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:49:13 INFO - Downloaded 10846565 bytes. 01:49:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:49:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:49:13 INFO - Return code: 0 01:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:13 INFO - https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:49:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:49:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:49:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:49:18 INFO - Downloaded 54143900 bytes. 01:49:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:49:18 INFO - mkdir: /builds/slave/test/properties 01:49:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:49:18 INFO - Writing to file /builds/slave/test/properties/build_url 01:49:18 INFO - Contents: 01:49:18 INFO - build_url:https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:49:19 INFO - Running post-action listener: _resource_record_post_action 01:49:19 INFO - Running post-action listener: set_extra_try_arguments 01:49:19 INFO - ##### 01:49:19 INFO - ##### Running populate-webroot step. 01:49:19 INFO - ##### 01:49:19 INFO - Running pre-action listener: _resource_record_pre_action 01:49:19 INFO - Running main action method: populate_webroot 01:49:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:49:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:49:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:49:19 INFO - '--tppagecycles', 01:49:19 INFO - '7'], 01:49:19 INFO - 'tests': ['tsvgm']}}, 01:49:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:49:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:49:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:49:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:49:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:49:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:49:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:49:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:19 INFO - 'talos_options': ['--e10s'], 01:49:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:49:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:19 INFO - 'tests': ['damp', 'tps']}, 01:49:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:19 INFO - 'talos_options': ['--e10s'], 01:49:19 INFO - 'tests': ['damp', 'tps']}, 01:49:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:49:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:49:19 INFO - 'other': {'tests': ['a11yr', 01:49:19 INFO - 'ts_paint', 01:49:19 INFO - 'tpaint', 01:49:19 INFO - 'sessionrestore', 01:49:19 INFO - 'sessionrestore_no_auto_restore', 01:49:19 INFO - 'tabpaint']}, 01:49:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:49:19 INFO - 'tests': ['a11yr', 01:49:19 INFO - 'ts_paint', 01:49:19 INFO - 'tpaint', 01:49:19 INFO - 'sessionrestore', 01:49:19 INFO - 'sessionrestore_no_auto_restore', 01:49:19 INFO - 'tabpaint']}, 01:49:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:49:19 INFO - 'tests': ['a11yr', 01:49:19 INFO - 'ts_paint', 01:49:19 INFO - 'tpaint', 01:49:19 INFO - 'sessionrestore', 01:49:19 INFO - 'sessionrestore_no_auto_restore', 01:49:19 INFO - 'tabpaint']}, 01:49:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:49:19 INFO - 'tests': ['a11yr', 01:49:19 INFO - 'ts_paint', 01:49:19 INFO - 'tpaint', 01:49:19 INFO - 'sessionrestore', 01:49:19 INFO - 'sessionrestore_no_auto_restore', 01:49:19 INFO - 'tabpaint']}, 01:49:19 INFO - 'other_l64': {'tests': ['a11yr', 01:49:19 INFO - 'ts_paint', 01:49:19 INFO - 'tpaint', 01:49:19 INFO - 'sessionrestore', 01:49:19 INFO - 'sessionrestore_no_auto_restore', 01:49:19 INFO - 'tabpaint']}, 01:49:19 INFO - 'other_nol64': {'tests': ['a11yr', 01:49:19 INFO - 'ts_paint', 01:49:19 INFO - 'tpaint', 01:49:19 INFO - 'sessionrestore', 01:49:19 INFO - 'sessionrestore_no_auto_restore', 01:49:19 INFO - 'tabpaint']}, 01:49:19 INFO - 'svgr': {'tests': ['tsvgx', 01:49:19 INFO - 'tsvgr_opacity', 01:49:19 INFO - 'tart', 01:49:19 INFO - 'tscrollx', 01:49:19 INFO - 'cart']}, 01:49:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:49:19 INFO - 'tests': ['tsvgx', 01:49:19 INFO - 'tsvgr_opacity', 01:49:19 INFO - 'tart', 01:49:19 INFO - 'tscrollx', 01:49:19 INFO - 'cart']}, 01:49:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:19 INFO - 'tests': ['tp5o']}, 01:49:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:19 INFO - 'talos_options': ['--e10s'], 01:49:19 INFO - 'tests': ['tp5o']}, 01:49:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:19 INFO - 'talos_options': ['--xperf_path', 01:49:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:49:19 INFO - 'tests': ['tp5n']}, 01:49:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:19 INFO - 'talos_options': ['--e10s', 01:49:19 INFO - '--xperf_path', 01:49:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:49:19 INFO - 'tests': ['tp5n']}}, 01:49:19 INFO - 'talos.zip': {'path': '', 01:49:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:49:19 INFO - Running post-action listener: _resource_record_post_action 01:49:19 INFO - ##### 01:49:19 INFO - ##### Running create-virtualenv step. 01:49:19 INFO - ##### 01:49:19 INFO - Running pre-action listener: _resource_record_pre_action 01:49:19 INFO - Running main action method: create_virtualenv 01:49:19 INFO - Creating virtualenv /builds/slave/test/build/venv 01:49:19 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 01:49:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:49:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:49:19 INFO - Using real prefix '/usr' 01:49:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:49:19 INFO - Installing distribute.............................................................................................................................................................................................done. 01:49:21 INFO - Installing pip.................done. 01:49:21 INFO - Return code: 0 01:49:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:49:21 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')]} 01:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:21 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')]} 01:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:21 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 0x7fbe71559f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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-1458290944.610111-1320820025', '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 01:49:21 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 01:49:21 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 01:49:21 INFO - Using env: {'DISPLAY': ':0', 01:49:21 INFO - 'HOME': '/home/cltbld', 01:49:21 INFO - 'LANG': 'en_US.UTF-8', 01:49:21 INFO - 'LANGUAGE': 'en_US:en', 01:49:21 INFO - 'LOGNAME': 'cltbld', 01:49:21 INFO - 'MAIL': '/var/mail/cltbld', 01:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:21 INFO - 'MOZ_NO_REMOTE': '1', 01:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:21 INFO - 'NO_EM_RESTART': '1', 01:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:21 INFO - 'PWD': '/builds/slave/test', 01:49:21 INFO - 'SHELL': '/bin/bash', 01:49:21 INFO - 'SHLVL': '1', 01:49:21 INFO - 'TERM': 'linux', 01:49:21 INFO - 'TMOUT': '86400', 01:49:21 INFO - 'USER': 'cltbld', 01:49:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025', 01:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:21 INFO - '_': '/tools/buildbot/bin/python'} 01:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:21 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 01:49:21 INFO - Cleaning up... 01:49:21 INFO - Return code: 0 01:49:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:49:21 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')]} 01:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:21 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')]} 01:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:21 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe71559f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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-1458290944.610111-1320820025', '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 01:49:21 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>=0.7.1'] in /builds/slave/test/build 01:49:21 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>=0.7.1 01:49:21 INFO - Using env: {'DISPLAY': ':0', 01:49:21 INFO - 'HOME': '/home/cltbld', 01:49:21 INFO - 'LANG': 'en_US.UTF-8', 01:49:21 INFO - 'LANGUAGE': 'en_US:en', 01:49:21 INFO - 'LOGNAME': 'cltbld', 01:49:21 INFO - 'MAIL': '/var/mail/cltbld', 01:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:21 INFO - 'MOZ_NO_REMOTE': '1', 01:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:21 INFO - 'NO_EM_RESTART': '1', 01:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:21 INFO - 'PWD': '/builds/slave/test', 01:49:21 INFO - 'SHELL': '/bin/bash', 01:49:21 INFO - 'SHLVL': '1', 01:49:21 INFO - 'TERM': 'linux', 01:49:21 INFO - 'TMOUT': '86400', 01:49:21 INFO - 'USER': 'cltbld', 01:49:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025', 01:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:21 INFO - '_': '/tools/buildbot/bin/python'} 01:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:22 INFO - Downloading/unpacking psutil>=0.7.1 01:49:22 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 01:49:22 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 01:49:22 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 01:49:22 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 01:49:22 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 01:49:22 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 01:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:49:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:49:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:49:24 INFO - Installing collected packages: psutil 01:49:24 INFO - Running setup.py install for psutil 01:49:24 INFO - building 'psutil._psutil_linux' extension 01:49:24 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 01:49:24 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 01:49:24 INFO - building 'psutil._psutil_posix' extension 01:49:24 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 01:49:24 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 01:49:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:49:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:49:24 INFO - Successfully installed psutil 01:49:24 INFO - Cleaning up... 01:49:24 INFO - Return code: 0 01:49:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:49:24 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')]} 01:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:24 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')]} 01:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:24 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe71559f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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-1458290944.610111-1320820025', '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 01:49:24 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.0.0'] in /builds/slave/test/build 01:49:24 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.0.0 01:49:24 INFO - Using env: {'DISPLAY': ':0', 01:49:24 INFO - 'HOME': '/home/cltbld', 01:49:24 INFO - 'LANG': 'en_US.UTF-8', 01:49:24 INFO - 'LANGUAGE': 'en_US:en', 01:49:24 INFO - 'LOGNAME': 'cltbld', 01:49:24 INFO - 'MAIL': '/var/mail/cltbld', 01:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:24 INFO - 'MOZ_NO_REMOTE': '1', 01:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:24 INFO - 'NO_EM_RESTART': '1', 01:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:24 INFO - 'PWD': '/builds/slave/test', 01:49:24 INFO - 'SHELL': '/bin/bash', 01:49:24 INFO - 'SHLVL': '1', 01:49:24 INFO - 'TERM': 'linux', 01:49:24 INFO - 'TMOUT': '86400', 01:49:24 INFO - 'USER': 'cltbld', 01:49:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025', 01:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:24 INFO - '_': '/tools/buildbot/bin/python'} 01:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:49:24 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 01:49:24 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 01:49:24 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 01:49:24 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 01:49:24 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 01:49:24 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 01:49:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:49:26 INFO - Installing collected packages: mozsystemmonitor 01:49:26 INFO - Running setup.py install for mozsystemmonitor 01:49:26 INFO - Successfully installed mozsystemmonitor 01:49:26 INFO - Cleaning up... 01:49:26 INFO - Return code: 0 01:49:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:49:26 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')]} 01:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:26 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')]} 01:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:26 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 0x7fbe71559f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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-1458290944.610111-1320820025', '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 01:49:26 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 01:49:26 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 01:49:26 INFO - Using env: {'DISPLAY': ':0', 01:49:26 INFO - 'HOME': '/home/cltbld', 01:49:26 INFO - 'LANG': 'en_US.UTF-8', 01:49:26 INFO - 'LANGUAGE': 'en_US:en', 01:49:26 INFO - 'LOGNAME': 'cltbld', 01:49:26 INFO - 'MAIL': '/var/mail/cltbld', 01:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:26 INFO - 'MOZ_NO_REMOTE': '1', 01:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:26 INFO - 'NO_EM_RESTART': '1', 01:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:26 INFO - 'PWD': '/builds/slave/test', 01:49:26 INFO - 'SHELL': '/bin/bash', 01:49:26 INFO - 'SHLVL': '1', 01:49:26 INFO - 'TERM': 'linux', 01:49:26 INFO - 'TMOUT': '86400', 01:49:26 INFO - 'USER': 'cltbld', 01:49:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025', 01:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:26 INFO - '_': '/tools/buildbot/bin/python'} 01:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:27 INFO - Downloading/unpacking blobuploader==1.2.4 01:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:28 INFO - Downloading blobuploader-1.2.4.tar.gz 01:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:49:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:49:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:29 INFO - Downloading docopt-0.6.1.tar.gz 01:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:49:29 INFO - Installing collected packages: blobuploader, requests, docopt 01:49:29 INFO - Running setup.py install for blobuploader 01:49:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:49:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:49:29 INFO - Running setup.py install for requests 01:49:30 INFO - Running setup.py install for docopt 01:49:30 INFO - Successfully installed blobuploader requests docopt 01:49:30 INFO - Cleaning up... 01:49:30 INFO - Return code: 0 01:49:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:49:30 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')]} 01:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:30 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')]} 01:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:30 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 0x7fbe71559f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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-1458290944.610111-1320820025', '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 01:49:30 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 01:49:30 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 01:49:30 INFO - Using env: {'DISPLAY': ':0', 01:49:30 INFO - 'HOME': '/home/cltbld', 01:49:30 INFO - 'LANG': 'en_US.UTF-8', 01:49:30 INFO - 'LANGUAGE': 'en_US:en', 01:49:30 INFO - 'LOGNAME': 'cltbld', 01:49:30 INFO - 'MAIL': '/var/mail/cltbld', 01:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:30 INFO - 'MOZ_NO_REMOTE': '1', 01:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:30 INFO - 'NO_EM_RESTART': '1', 01:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:30 INFO - 'PWD': '/builds/slave/test', 01:49:30 INFO - 'SHELL': '/bin/bash', 01:49:30 INFO - 'SHLVL': '1', 01:49:30 INFO - 'TERM': 'linux', 01:49:30 INFO - 'TMOUT': '86400', 01:49:30 INFO - 'USER': 'cltbld', 01:49:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025', 01:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:30 INFO - '_': '/tools/buildbot/bin/python'} 01:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:49:30 INFO - Running setup.py (path:/tmp/pip-htqZhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:49:30 INFO - Running setup.py (path:/tmp/pip-Lef6Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:49:30 INFO - Running setup.py (path:/tmp/pip-C90nJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:49:30 INFO - Running setup.py (path:/tmp/pip-__iM7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:49:30 INFO - Running setup.py (path:/tmp/pip-Q82ZKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:49:30 INFO - Running setup.py (path:/tmp/pip-nB9ZqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:49:30 INFO - Running setup.py (path:/tmp/pip-UAWW5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:49:31 INFO - Running setup.py (path:/tmp/pip-shBAsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:49:31 INFO - Running setup.py (path:/tmp/pip-GeD4ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:49:31 INFO - Running setup.py (path:/tmp/pip-DyvE3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:49:31 INFO - Running setup.py (path:/tmp/pip-Kk6wy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:49:31 INFO - Running setup.py (path:/tmp/pip-sWFhMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:49:31 INFO - Running setup.py (path:/tmp/pip-IOEUZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:49:31 INFO - Running setup.py (path:/tmp/pip-XFXokn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:31 INFO - Running setup.py (path:/tmp/pip-B50CZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:49:31 INFO - Running setup.py (path:/tmp/pip-SElJ5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:49:31 INFO - Running setup.py (path:/tmp/pip-DXK4fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:49:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:49:31 INFO - Running setup.py install for manifestparser 01:49:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:49:31 INFO - Running setup.py install for mozcrash 01:49:31 INFO - Running setup.py install for mozdebug 01:49:32 INFO - Running setup.py install for mozdevice 01:49:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:49:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:49:32 INFO - Running setup.py install for mozfile 01:49:32 INFO - Running setup.py install for mozhttpd 01:49:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:49:32 INFO - Running setup.py install for mozinfo 01:49:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:49:32 INFO - Running setup.py install for mozInstall 01:49:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:49:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:49:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:49:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:49:32 INFO - Running setup.py install for mozleak 01:49:32 INFO - Running setup.py install for mozlog 01:49:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:49:32 INFO - Running setup.py install for moznetwork 01:49:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:49:32 INFO - Running setup.py install for mozprocess 01:49:33 INFO - Running setup.py install for mozprofile 01:49:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:49:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:49:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:49:33 INFO - Running setup.py install for mozrunner 01:49:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:49:33 INFO - Running setup.py install for mozscreenshot 01:49:33 INFO - Running setup.py install for moztest 01:49:33 INFO - Running setup.py install for mozversion 01:49:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:49:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:49:33 INFO - Cleaning up... 01:49:33 INFO - Return code: 0 01:49:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:49:33 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')]} 01:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:33 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')]} 01:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:33 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 0x7fbe71559f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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-1458290944.610111-1320820025', '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 01:49:33 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 01:49:33 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 01:49:33 INFO - Using env: {'DISPLAY': ':0', 01:49:33 INFO - 'HOME': '/home/cltbld', 01:49:33 INFO - 'LANG': 'en_US.UTF-8', 01:49:33 INFO - 'LANGUAGE': 'en_US:en', 01:49:33 INFO - 'LOGNAME': 'cltbld', 01:49:33 INFO - 'MAIL': '/var/mail/cltbld', 01:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:33 INFO - 'MOZ_NO_REMOTE': '1', 01:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:33 INFO - 'NO_EM_RESTART': '1', 01:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:33 INFO - 'PWD': '/builds/slave/test', 01:49:33 INFO - 'SHELL': '/bin/bash', 01:49:33 INFO - 'SHLVL': '1', 01:49:33 INFO - 'TERM': 'linux', 01:49:33 INFO - 'TMOUT': '86400', 01:49:33 INFO - 'USER': 'cltbld', 01:49:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025', 01:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:33 INFO - '_': '/tools/buildbot/bin/python'} 01:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:49:33 INFO - Running setup.py (path:/tmp/pip-4vWDid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:49:33 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)) 01:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:49:33 INFO - Running setup.py (path:/tmp/pip-yB7yXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:49:33 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)) 01:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:49:33 INFO - Running setup.py (path:/tmp/pip-tvRm3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:49:33 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)) 01:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:49:33 INFO - Running setup.py (path:/tmp/pip-jSq6e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:49:34 INFO - Running setup.py (path:/tmp/pip-spX_42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:49:34 INFO - Running setup.py (path:/tmp/pip-ILnPoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:49:34 INFO - Running setup.py (path:/tmp/pip-6G3ui5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:49:34 INFO - Running setup.py (path:/tmp/pip-OL1XtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:49:34 INFO - Running setup.py (path:/tmp/pip-ipDnCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:49:34 INFO - Running setup.py (path:/tmp/pip-tqbm1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:49:34 INFO - Running setup.py (path:/tmp/pip-GKPY_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:49:34 INFO - Running setup.py (path:/tmp/pip-rKsevK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:49:34 INFO - Running setup.py (path:/tmp/pip-nasCIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:49:34 INFO - Running setup.py (path:/tmp/pip-libI9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:34 INFO - Running setup.py (path:/tmp/pip-JU6UX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:49:34 INFO - Running setup.py (path:/tmp/pip-jeu8D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:49:34 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)) 01:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:49:34 INFO - Running setup.py (path:/tmp/pip-AOxsDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:49:35 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)) 01:49:35 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)) 01:49:35 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)) 01:49:35 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)) 01:49:35 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)) 01:49:35 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)) 01:49:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:49:35 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 01:49:35 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 01:49:35 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 01:49:35 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 01:49:35 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 01:49:35 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 01:49:36 INFO - Downloading blessings-1.6.tar.gz 01:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:49:36 INFO - Installing collected packages: blessings 01:49:36 INFO - Running setup.py install for blessings 01:49:37 INFO - Successfully installed blessings 01:49:37 INFO - Cleaning up... 01:49:37 INFO - Return code: 0 01:49:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:49:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:49:37 INFO - Reading from file tmpfile_stdout 01:49:37 INFO - Current package versions: 01:49:37 INFO - argparse == 1.2.1 01:49:37 INFO - blessings == 1.6 01:49:37 INFO - blobuploader == 1.2.4 01:49:37 INFO - docopt == 0.6.1 01:49:37 INFO - manifestparser == 1.1 01:49:37 INFO - mozInstall == 1.12 01:49:37 INFO - mozcrash == 0.17 01:49:37 INFO - mozdebug == 0.1 01:49:37 INFO - mozdevice == 0.48 01:49:37 INFO - mozfile == 1.2 01:49:37 INFO - mozhttpd == 0.7 01:49:37 INFO - mozinfo == 0.9 01:49:37 INFO - mozleak == 0.1 01:49:37 INFO - mozlog == 3.1 01:49:37 INFO - moznetwork == 0.27 01:49:37 INFO - mozprocess == 0.22 01:49:37 INFO - mozprofile == 0.28 01:49:37 INFO - mozrunner == 6.11 01:49:37 INFO - mozscreenshot == 0.1 01:49:37 INFO - mozsystemmonitor == 0.0 01:49:37 INFO - moztest == 0.7 01:49:37 INFO - mozversion == 1.4 01:49:37 INFO - psutil == 3.1.1 01:49:37 INFO - requests == 1.2.3 01:49:37 INFO - wsgiref == 0.1.2 01:49:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:49: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')]} 01:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49: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')]} 01:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:37 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 0x7fbe71559f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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-1458290944.610111-1320820025', '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 01:49:37 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 01:49:37 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 01:49:37 INFO - Using env: {'DISPLAY': ':0', 01:49:37 INFO - 'HOME': '/home/cltbld', 01:49:37 INFO - 'LANG': 'en_US.UTF-8', 01:49:37 INFO - 'LANGUAGE': 'en_US:en', 01:49:37 INFO - 'LOGNAME': 'cltbld', 01:49:37 INFO - 'MAIL': '/var/mail/cltbld', 01:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:37 INFO - 'MOZ_NO_REMOTE': '1', 01:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:37 INFO - 'NO_EM_RESTART': '1', 01:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:37 INFO - 'PWD': '/builds/slave/test', 01:49:37 INFO - 'SHELL': '/bin/bash', 01:49:37 INFO - 'SHLVL': '1', 01:49:37 INFO - 'TERM': 'linux', 01:49:37 INFO - 'TMOUT': '86400', 01:49:37 INFO - 'USER': 'cltbld', 01:49:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025', 01:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:37 INFO - '_': '/tools/buildbot/bin/python'} 01:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:37 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)) 01:49:37 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)) 01:49:37 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)) 01:49:37 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)) 01:49:37 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)) 01:49:37 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)) 01:49:37 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)) 01:49:37 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)) 01:49:37 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)) 01:49:37 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)) 01:49:37 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)) 01:49:37 INFO - Cleaning up... 01:49:37 INFO - Return code: 0 01:49:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:49: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')]} 01:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49: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')]} 01:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:37 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 0x7fbe71559f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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-1458290944.610111-1320820025', '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 01:49:37 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 01:49:37 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 01:49:37 INFO - Using env: {'DISPLAY': ':0', 01:49:37 INFO - 'HOME': '/home/cltbld', 01:49:37 INFO - 'LANG': 'en_US.UTF-8', 01:49:37 INFO - 'LANGUAGE': 'en_US:en', 01:49:37 INFO - 'LOGNAME': 'cltbld', 01:49:37 INFO - 'MAIL': '/var/mail/cltbld', 01:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:37 INFO - 'MOZ_NO_REMOTE': '1', 01:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:37 INFO - 'NO_EM_RESTART': '1', 01:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:37 INFO - 'PWD': '/builds/slave/test', 01:49:37 INFO - 'SHELL': '/bin/bash', 01:49:37 INFO - 'SHLVL': '1', 01:49:37 INFO - 'TERM': 'linux', 01:49:37 INFO - 'TMOUT': '86400', 01:49:37 INFO - 'USER': 'cltbld', 01:49:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025', 01:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:37 INFO - '_': '/tools/buildbot/bin/python'} 01:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:37 INFO - Downloading/unpacking jsonschema 01:49:37 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 01:49:37 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 01:49:37 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 01:49:37 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 01:49:37 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 01:49:37 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 01:49:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:49:39 INFO - Downloading/unpacking functools32 (from jsonschema) 01:49:39 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 01:49:39 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 01:49:39 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 01:49:39 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 01:49:39 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 01:49:39 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 01:49:39 INFO - Downloading functools32-3.2.3-2.tar.gz 01:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:49:39 INFO - warning: no files found matching '*.txt' 01:49:39 INFO - no previously-included directories found matching 'build' 01:49:39 INFO - no previously-included directories found matching 'dist' 01:49:39 INFO - no previously-included directories found matching '.git*' 01:49:39 INFO - Installing collected packages: jsonschema, functools32 01:49:39 INFO - Running setup.py install for functools32 01:49:39 INFO - warning: no files found matching '*.txt' 01:49:39 INFO - no previously-included directories found matching 'build' 01:49:39 INFO - no previously-included directories found matching 'dist' 01:49:39 INFO - no previously-included directories found matching '.git*' 01:49:40 INFO - Successfully installed jsonschema functools32 01:49:40 INFO - Cleaning up... 01:49:40 INFO - Return code: 0 01:49:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:40 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 0x7fbe71559f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, '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-1458290944.610111-1320820025', '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 01:49:40 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 01:49:40 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 01:49:40 INFO - Using env: {'DISPLAY': ':0', 01:49:40 INFO - 'HOME': '/home/cltbld', 01:49:40 INFO - 'LANG': 'en_US.UTF-8', 01:49:40 INFO - 'LANGUAGE': 'en_US:en', 01:49:40 INFO - 'LOGNAME': 'cltbld', 01:49:40 INFO - 'MAIL': '/var/mail/cltbld', 01:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:40 INFO - 'MOZ_NO_REMOTE': '1', 01:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:40 INFO - 'NO_EM_RESTART': '1', 01:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:40 INFO - 'PWD': '/builds/slave/test', 01:49:40 INFO - 'SHELL': '/bin/bash', 01:49:40 INFO - 'SHLVL': '1', 01:49:40 INFO - 'TERM': 'linux', 01:49:40 INFO - 'TMOUT': '86400', 01:49:40 INFO - 'USER': 'cltbld', 01:49:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025', 01:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:40 INFO - '_': '/tools/buildbot/bin/python'} 01:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:40 INFO - Downloading/unpacking flake8 01:49:40 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 01:49:40 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 01:49:40 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 01:49:40 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 01:49:40 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 01:49:40 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 01:49:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:49:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:49:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 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 01:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:49:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:42 INFO - no previously-included directories found matching 'docs/_build' 01:49:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:49:42 INFO - Running setup.py install for pep8 01:49:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:42 INFO - no previously-included directories found matching 'docs/_build' 01:49:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:49:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:49:43 INFO - Cleaning up... 01:49:43 INFO - Return code: 0 01:49:43 INFO - Running post-action listener: _resource_record_post_action 01:49:43 INFO - Running post-action listener: _start_resource_monitoring 01:49:43 INFO - Starting resource monitoring. 01:49:43 INFO - ##### 01:49:43 INFO - ##### Running install step. 01:49:43 INFO - ##### 01:49:43 INFO - Running pre-action listener: _resource_record_pre_action 01:49:43 INFO - Running main action method: install 01:49:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:49:43 INFO - Reading from file tmpfile_stdout 01:49:43 INFO - Detecting whether we're running mozinstall >=1.0... 01:49:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:49:43 INFO - Reading from file tmpfile_stdout 01:49:43 INFO - Output received: 01:49:43 INFO - Usage: mozinstall [options] installer 01:49:43 INFO - Options: 01:49:43 INFO - -h, --help show this help message and exit 01:49:43 INFO - -d DEST, --destination=DEST 01:49:43 INFO - Directory to install application into. [default: 01:49:43 INFO - "/builds/slave/test"] 01:49:43 INFO - --app=APP Application being installed. [default: firefox] 01:49:43 INFO - mkdir: /builds/slave/test/build/application 01:49:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:49:58 INFO - Reading from file tmpfile_stdout 01:49:58 INFO - Output received: 01:49:58 INFO - /builds/slave/test/build/application/firefox/firefox 01:49:58 INFO - Running post-action listener: _resource_record_post_action 01:49:58 INFO - ##### 01:49:58 INFO - ##### Running run-tests step. 01:49:58 INFO - ##### 01:49:58 INFO - Running pre-action listener: _resource_record_pre_action 01:49:58 INFO - Running main action method: run_tests 01:49:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:49:58 INFO - Python 2.7.3 01:49:58 INFO - Return code: 0 01:49:58 INFO - grabbing minidump binary from tooltool 01:49: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')]} 01:49:58 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866410>, '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 0x2867310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28677a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:49:58 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 01:49:58 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 01:49:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:49:59 INFO - Return code: 0 01:49:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:49:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:49:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:49:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:49:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:50:00 INFO - Return code: 0 01:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.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 01:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.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 01:50:00 INFO - Using env: {'DISPLAY': ':0', 01:50:00 INFO - 'HOME': '/home/cltbld', 01:50:00 INFO - 'LANG': 'en_US.UTF-8', 01:50:00 INFO - 'LANGUAGE': 'en_US:en', 01:50:00 INFO - 'LOGNAME': 'cltbld', 01:50:00 INFO - 'MAIL': '/var/mail/cltbld', 01:50:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:50:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:00 INFO - 'MOZ_NO_REMOTE': '1', 01:50:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:00 INFO - 'NO_EM_RESTART': '1', 01:50:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:00 INFO - 'PWD': '/builds/slave/test', 01:50:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:50:00 INFO - 'SHELL': '/bin/bash', 01:50:00 INFO - 'SHLVL': '1', 01:50:00 INFO - 'TERM': 'linux', 01:50:00 INFO - 'TMOUT': '86400', 01:50:00 INFO - 'USER': 'cltbld', 01:50:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458290944.610111-1320820025', 01:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:00 INFO - '_': '/tools/buildbot/bin/python'} 01:50:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.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 01:50:00 INFO - mozversion application_buildid: 20160318010713 01:50:00 INFO - mozversion application_changeset: 7f5889e82e92a43294a9e0d5e393e38bbf59632d 01:50:00 INFO - mozversion application_display_name: Nightly 01:50:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:50:00 INFO - mozversion application_name: Firefox 01:50:00 INFO - mozversion application_remotingname: firefox 01:50:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:50:00 INFO - mozversion application_vendor: Mozilla 01:50:00 INFO - mozversion application_version: 48.0a1 01:50:00 INFO - mozversion platform_buildid: 20160318010713 01:50:00 INFO - mozversion platform_changeset: 7f5889e82e92a43294a9e0d5e393e38bbf59632d 01:50:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:50:00 INFO - mozversion platform_version: 48.0a1 01:50:00 INFO - using testdate: 1458291000 01:50:00 INFO - actual date: 1458291000 01:50:00 INFO - starting webserver on 'localhost:55088' 01:50:00 INFO - SUITE-START | Running 2 tests 01:50:00 INFO - TEST-START | dromaeo_css 01:50:00 INFO - operating with platform_type : linux_ 01:50:00 INFO - Initialising browser for dromaeo_css test... 01:50:00 INFO - TEST-INFO | started process 7821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYYEaVu/profile http://localhost:55088/getInfo.html) 01:50:04 INFO - PROCESS | 7821 | __metrics Screen width/height:1600/1200 01:50:04 INFO - PROCESS | 7821 | colorDepth:24 01:50:04 INFO - PROCESS | 7821 | Browser inner width/height: 1024/697 01:50:04 INFO - PROCESS | 7821 | __metrics 01:50:05 ERROR - PROCESS | 7821 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:50:05 INFO - PROCESS | 7821 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 01:50:05 INFO - TEST-INFO | 7821: exit 0 01:50:05 INFO - Browser initialized. 01:50:05 INFO - Running cycle 1/1 for dromaeo_css test... 01:50:05 INFO - TEST-INFO | started process 7912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYYEaVu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:50:17 INFO - PROCESS | 7912 | RSS: Main: 154619904 01:50:17 INFO - PROCESS | 7912 | 01:51:08 INFO - PROCESS | 7912 | 1458291068923 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:53:20 INFO - PROCESS | 7912 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55088/tests/dromaeo/cssquery-ext.html) 01:53:21 INFO - PROCESS | 7912 | RSS: Main: 266756096 01:53:21 INFO - PROCESS | 7912 | 01:56:23 INFO - PROCESS | 7912 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-ext.html (next: http://localhost:55088/tests/dromaeo/cssquery-jquery.html) 01:56:24 INFO - PROCESS | 7912 | RSS: Main: 243339264 01:56:24 INFO - PROCESS | 7912 | 01:59:26 INFO - PROCESS | 7912 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55088/tests/dromaeo/cssquery-mootools.html) 01:59:26 INFO - PROCESS | 7912 | RSS: Main: 240541696 01:59:26 INFO - PROCESS | 7912 | 02:02:28 INFO - PROCESS | 7912 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55088/tests/dromaeo/cssquery-prototype.html) 02:02:29 INFO - PROCESS | 7912 | RSS: Main: 222973952 02:02:29 INFO - PROCESS | 7912 | 02:05:31 INFO - PROCESS | 7912 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55088/tests/dromaeo/cssquery-yui.html) 02:05:32 INFO - PROCESS | 7912 | RSS: Main: 206573568 02:05:32 INFO - PROCESS | 7912 | 02:08:34 INFO - PROCESS | 7912 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-yui.html (next: http://localhost:55088/tests/dromaeo/cssquery-dojo.html) 02:08:35 INFO - PROCESS | 7912 | RSS: Main: 303845376 02:08:35 INFO - PROCESS | 7912 | 02:08:35 INFO - PROCESS | 7912 | __start_tp_report 02:08:35 INFO - PROCESS | 7912 | _x_x_mozilla_page_load 02:08:35 INFO - PROCESS | 7912 | _x_x_mozilla_page_load_details 02:08:35 INFO - PROCESS | 7912 | |i|pagename|runs| 02:08:35 INFO - PROCESS | 7912 | |0;dojo.html;2610.9216723498294;2673.3984853407987;2689.287338855205;2702.594610808377;2725.1143378402016;4648.65135114866;4700.200965835807;4712.434507859058;4725.598324142447;4777.235642297233;4662.930056049154;4698.976505117478;4699.600533954609;4701.153792317382;4745.335653008581;4263.083437061031;4337.696361254713;4346.174226896879;4406.427164468614;4441.178381999324;4273.444452221207;4368.410264614284;4419.558044195587;4438.26768583185;4442.600165985061;4287.3140297552245;4325.178216138924;4335.241332766785;4350.6736994725525;4389.495208051051;4346.065595896897;4350.956490435086;4364.585364390377;4380.934285985712;4389.5390983946545;4274.358846173068;4330.9389199645975;4339.435873336446;4344.869653910388;4391.934120988188;4585.060062687141;4660.277656963176;4690.132325519789;4691.6481263905;4694.929576056362;5014.799408023711;5027.49725027498;5036.143855544529;5038.294638750578;5080.695158290478;4995.8501244962345;5054.898902021939;5074.467180945984;5076.035553244872;5081.79672813087;4701.130290896195;4733.360996265529;4765.904681906342;4803.03939212159;4810.735409552508;5223.634345595772;5231.738413079331;5236.39781425141;5238.73806309683;5247.317848679647;4871.29366241893;4940.135476291634;5026.4973502649445;5034.521720436553;5067.214581739836;5038.748062596929;5115.2071428928575;5136.43499215086;5141.820036298712;5161.793528258828;5042.319286896295;5052.8484145475695;5055.545000949932;5059.06407314648;5102.285680004802;4937.925931111036;5029.1953287473825;5041.218611115283;5045.470225626256;5046.914913293659;4156.708094327643;4185.916281674349;4195.265828480004;4202.537720850704;4202.873913782591;3684.631536846294;3727.4408838674417;3762.962370376316;3771.6982641389172;3811.9809400952818;4401.1417773534495;4401.295792673157;4404.2512772828695;4427.579379958963;4458.598726114666;4942.1104201244125;5127.974360128175;5130.127878260705;5130.769115389742;5133.435322114565;4324.416203812445;4388.846390376321;4391.626711729475;4412.911741765147;4431.623312018514;4481.551844815557;4508.436445444319;4520.751358675238;4548.863534093983;4556.24821904382;4722.456917454399;4783.091212669582;4783.115123702126;4790.544898234802;4792.113459010095;5066.974665126798;5081.288619593186;5096.872578185575;5118.33461649998;5149.716765577779;4838.032393521239;4840.201366774443;4845.1278769820365;4849.393825771778;4899.216125420058;4936.432310284364;4944.505549445027;5028.170351891897;5061.974690126526;5078.136716758087;5077.8730531737;5088.54203121706;5094;5100.719460429564;5138;4951.3810773653295;4952.5542701157065;4953.777080031336;4956.77694503741;4995.425526064549;4825.6139508839915;4894.681845680019;4974.801007959641;4995.775190116527;5006.924896126488;4836.492168322276;4853.417589889236;4856.077345304381;4889.853304400874;4904.779284932258;4922.040202160544;4941.825834888724;4947.925781113358;4949.975250123726;4996.175631020841;4766.833160839493;4772.284157376283;4854.2233242681;4874.805007799649;4878.975605121952 02:08:35 INFO - PROCESS | 7912 | |1;ext.html;544.7194694732212;556.6854727079198;565.5447364871279;582.1122787748683;601.9398060193981;27396.589051164225;36163.63836361636;36168.63831361686;36299;36339;39412;39868.80065599668;39924.40113398294;39952.60047399525;40029.39955900657;7651.426143039266;7822.139564647884;7822.647980840848;7825.256600622932;7827.804304892366;7458.366038886674;7709.190534993829;7820.648070836826;7824.374050076009;7825.591393549159;7477.252274772533;7482.9251707483045;7486;7486.962565187167;7487.064116985377;7320.853582928312;7703.807404814925;7724.266194711549;7749.806254843617;7805;7310.195878453366;7320.828667413241;7342.375898048672;7379.3727533159745;7429.034225550698;38492;38928.610713892784;39062.41406378907;39092;39095.41356879649;3137.905862824119;3306.173456635841;3453.568303962005;3632.0919770057485;3742.2328422673286;29183.562246566107;29272.572291649005;29670.258243543867;29826.70173298261;29885;3137.7332926701256;3155.637101733307;3189.9681003189903;3287.4247006773717;3380.053584996205;245095;246712;247275;248590;248634;61130;61332.386676132664;61347;61412.69293653503;61465.692671537254;65043;65366;65945;65990.34009659938;66085.33914660888;13469.259190744408;13577.389017494237;13603.727925441633;13619.863801362058;13656.112352697042;10364.637237696796;10407.06336429725;10424.843627345595;10426.270161088803;10432.2697411182;19235.615287694167;19463.03393768494;19528.558930133735;19571.217151313787;19581;7835.451518393657;7955.641996110189;8008.239217274349;8123.228293312126;8177.427580069338;841.5792103948025;928.8653145293895;934.4860326820358;939.6664184214505;962.7208109648124;27671.169864904085;27720.584191237147;28058.71941280602;28261.717382825907;28542.14373568796;1020.6529779874878;1042.8122937871256;1046.6546039806997;1052.921030922684;1115.4757264085868;14439.783403248959;14599.19704416246;14868.479603214051;14877.18175500358;15582.9220853895;365258;374976;377200;377965;378316;52188.95622087537;52818.735906320224;52856;52919.735401322745;52961.735191323794;1157.4964890272759;1166.6966588687003;1233.9259644421363;1278.1947373154853;1289.3617659258728;25411.36471588225;26942.191734248005;27526.311842204104;27652.308692282048;28327.15018549447;39690;40217.1956560873;40376.79811600923;40685.79657101695;40687.38968915409;227883;236059;236392;236582;236752;27319.72680273172;31919.840400797846;32229.838850805594;32482.837585811918;32646.183845404055;38495.230095398496;38733;39420.21159576735;39802.80098599489;40231;32607.836960815992;33836;34598;34751;34812.303753925284;33473.83263083669;34131.82934085413;34191.31617367688;34266.82866585651;34288.48567271443;33503.704584175364;33710.32579348448;34024.82987585046;34314.31371372509;34324.313513730085;29254;29979.400411992076;30298.24254393658;30358.241043973194;30387.240318991317;23927.401814954766;24010;24051.759482404952;24228.515429690953;24301.878490607432 02:08:35 INFO - PROCESS | 7912 | |2;jquery.html;357.19452634309613;360.63395653411794;366.75060958548187;371.5188830464548;374.1917458290094;15188.392464301429;15307.38770449182;16359.918200408982;16397;16407.851450398462;15679;15871.206439678028;16780.496585102435;16796.244169012392;16798.32806687734;4928.334674818907;5000.224965130402;5155.123628983082;5155.71643559604;5160.045391602547;5109.974450127745;5124.564412024983;5135.2297155426795;5142.151544995071;5159.819406320779;4958.528939750718;5043.084620577375;5056.165732654108;5092.79628814847;5102.897942041175;5043.848684539433;5098.668586541863;5102.336696229503;5104;5111.744412779365;4574.359589657451;4580.992181720049;4582.885427864297;4583.220852455057;4586.449626044896;18271.72592411115;19233.61532769337;19262.71105933412;19271.421857344303;19308.227670893146;1905.1141219332937;1914.9138288777037;1915.7030660247544;1936.564273038555;1938.1472152252963;12067.215630984047;12344.81482777759;12362.629121126382;12728.74542509154;12787.488500459971;1723.4571110100278;1775.0947017021283;1863.413024897153;1868.7757469103658;1925.3261358524544;45082.54917450816;51874.740626297;52180;55211.723941380435;59768.40231597715;9544.809103817885;9611.615535378507;9639.759006024906;9664.661736839318;9823.557939892722;11420.14348923834;12260.080493962989;12328.630141095782;12424.75150497003;12463.75072498545;6794.286599906938;6930.341617546325;7206.387457066103;7210.459215558749;7219;6513.055606936968;6683.164604424447;6743.966280168568;6867.553609015398;6879.346462086094;5789.913151302734;5888.587798854125;5907.32065812437;5919.3192782829665;5995.52035837132;1737.6611560745532;1759.1556053094587;1761.8414342709218;1781.7238328059173;1786.44497450076;876.7588913048835;899.595182168027;951.2770294576034;966.990330096704;998.9750256243507;16050.117243551484;16348.264328105264;16744.748828767577;16765;17030;860.8794768732382;882.9161229683169;901.6618767962015;909.2271569166156;946.8011717539256;9409.200217981548;9465.337426380225;9509.524523773784;9720.805583888283;9770.755731106638;408498;412740;414638;415443;431592;60993;61078.69460652668;62078;62669.68665156645;62919.6854015727;943.556528431636;959.2517836087862;960.2989817433313;968.1673760565908;976.4824642939253;14418.927905360406;14695.853041469449;14755.778663320274;14788.11271323724;14821.184834834188;34468;35533;35656.108597285274;36714;36718;42946.570534295504;45930.54069459263;45969.31046034245;46265.76867115643;46276.07447850957;7084.46866485026;7258.491905566771;7297.525660832029;7339.926600733925;7430.851382972419;8378.790530236793;10658.467076645982;10975.341479510935;11365.48855301497;11409.942950285196;9340.673076442563;9881.901180988098;9888.406695598287;10142.29003969715;10320.071193592312;9506.90493095088;9653.9034609653;9806.607735690777;9902.653407130716;10027.097561219525;9596.328257021942;9860.901390985999;9953.552090155816;10112.241581881535;10283.280170388001;7330.340269375782;7445.069366329209;7485.278385971148;7485.588292643957;7546.471746977879;7941.761747147595;9470.668526601536;10323.793524129325;10506.527206275583;10549.314294570828 02:08:35 INFO - PROCESS | 7912 | |3;mootools.html;1291.7803973324533;1436.8778653814425;1458.6790906000676;1623.6265658898453;1816.4369045595865;7398.112226532817;7614.809629759245;7632.58020808856;7642.503237289579;7643.961780191091;7492.138404083532;7661.808454788633;7686.039245094364;7699.461037727361;7703.53778773274;1922.2599299269812;1969.7045443183565;1972.8816271023713;2302.896369663365;2339.087755775249;2257.5146343536135;2313.826463015272;2315.1202543033623;2315.2012555668266;2316.6756654068445;2250.054976909702;2252.68462415262;2257.0633187227363;2257.0745994142403;2343.945224648915;2236.552689462114;2258.604744169772;2263.3323169664823;2266.048259730917;2266.4787098967163;2318.4783423729696;2329.8019668328043;2330.114556468548;2331.7318508371586;2332.24202134307;7641.121271053845;7692.076950765888;7698.884516732253;7706.306432421053;7716.228377162239;4734.26618874075;4837.927431088537;4848.369711937426;4861.538153875376;4864.464908860023;3010.8946186883572;3068.125584208512;3204.1669166016773;3235.9352812943607;3237.7733558650903;993.4287784523927;1004.2167109654408;1027.0705011964185;1039.828428309328;1062.5271754069443;10729;10745;10760.3543787373;10770.138388928945;10788.136949044057;4477.440319960005;4512.503624601291;4603.8849028773875;4606.539346065367;4606.723596584216;9110.954445227731;9144.222741067084;9144.588493517807;9157.45055296671;9184.586693598803;4866.221404575251;4879.829205977845;4884.0476107159475;4884.5603895649565;4885;3740.8877733668032;4259.5101563319995;4366.825326986885;4402.229609818333;4404.933925991113;3800.8669696560487;3874.9031274217805;3876.321643712339;3900.1614652849776;3934.7245692801803;1269.1850653565305;1289.2457912121513;1292.883640472362;1300.4148133340034;1305.934703264833;1194.1760185471996;1199.898008669273;1209.7157168065673;1220.1337050693928;1225.2342286071205;7106.5736055836815;7163.785086447415;7222.855542889113;7224.060872086595;7309.634518274065;1061.6496556136456;1064.8083344997974;1071.212658695858;1078.396098185019;1104.536094840169;5258.2375555544995;5269.55208807248;5338.039152952429;5339.279197308391;5348.679079255257;9358.719238422858;9366.531673416303;9617.086376794194;9652.517374131265;9655.517224138765;9533.761655958657;9574.856377154349;9594.328397012281;9627.56675949584;9637.42175469474;7254.274572542704;7354.749692552172;7399.260073992666;7473.364763995121;7479.476436649491;6976.825579360557;7035;7035.085438892911;7040.119985001875;7068.823279418056;8384.245417912418;8493.617787199468;8597.484150950962;8630;8631.352648551509;8649.56752162402;8900.287976961958;9025.954870225607;9030.63877444895;9069.909300906906;6255.530835187288;6340.112384266298;6345.714442850175;6355.713992870239;6394.360563943568;7317.341439270491;7345.3021962913435;7383.409327253914;7428.814279643052;7468.589227592317;6665.233498147775;6778.084958530535;6834.487413444111;6921.065656136358;6956.130483689539;6616.735330586916;6628;6636.900446493403;6706.731730730716;6721.22705888829;6799.694013769491;6846.212685541027;6875.243723190545;6881.587104773729;7014.473914456538;6413.807585772434;6415.615063096043;6463.515236357198;6471.579347342407;6473.967630161819;6403.96798016007;6441.774537891151;6454.741810327534;6456.451201647725;6458.451031662361 02:08:35 INFO - PROCESS | 7912 | |4;prototype.html;326.35056238086213;327.464595386543;327.52999445795285;331.43159481489226;333.5030804101887;5319.654222475537;5349;5357.464253574641;5414.810481633143;5450.618456708032;5303.178007408848;5333.466653334664;5337.252784610148;5345.4387289334645;5348.572114230862;4016.31722607156;4110.588941105895;4196.9580304197025;4200.0969791494745;4224.493060832704;4187.811548480326;4201.117765269282;4201.70588058836;4209.6000879916355;4209.684273679486;4160.7087503874745;4201.747895126302;4206.179794939988;4208.936865947013;4210.263203939314;3958.604139586033;4054.432379466877;4135.6898232632675;4176.728512646669;4183.435236243099;3689.1146124929824;3700.2229531798353;3701.555813302394;3705.1478160023344;3712.573054098786;5154.742262886878;5166.276721259027;5171.896562068738;5175.844724658266;5176.870578235536;4865.34317867087;4871.171900776876;4872.975635121802;4874;4883.413990321149;5689.288838895138;5700.087985922274;5702.572307076985;5704.77180912763;5728.68492232927;3975.6421922026866;4072.9185416291507;4082.7346222495444;4087.2438598859308;4087.7751723655188;5936.139259807347;5991.700414979277;5998.220231369894;5999.580029397944;6033.728482218311;4165.687573432005;4181.853635122817;4184.81168347419;4194.853180138681;4195.811188496525;4241.63946064588;4244.045089854758;4246.002189485468;4246.681498887596;4250.511191212988;4794.520547945247;4815.422149342101;4819.349387832668;4822.324874517571;4825;5701.173329867146;5707.942920570824;5721.456461636138;5736.741846616912;5742.339630942495;1401.9439222431192;1482.48113160393;1506.4727345429012;1506.495324066428;1512.0322993284308;913.4975763330275;957.2533423929347;962.3119469579144;973.5424350555228;979.4661909259471;4933.827316043993;4951.777170027357;4959.231319145538;4962.60299176065;4964.429090654548;5829.504492118217;5830.47525722687;5836.766529338779;5837.153612726131;5840.649561026267;4939.777710003059;4948.752562371867;4950.2079667253065;4962.727050012284;4963.801447942042;3099.9225019374244;3146.11908665574;3146.678395074074;3148.889788857379;3153.542736303223;5548.140038294071;5554.0835762099605;5556.111022236423;5561.916571251353;5562.3881373048935;5917.230760001258;6172.783952561728;6173.536984726164;6181.412765787243;6183.721732521957;5660.462256085665;5689.9146512802345;5691.573132015033;5692.231548740867;5698.886022279448;5975.223220981245;5978.461938425388;5980.790672326448;5983.34183239852;5983.820485385445;5866.823995280149;5870.178175055581;5871.500922421642;5874.441928016831;5875.383084776037;5442.782288708408;5671.631343962629;5679.829605111853;5688.317401911797;5691.060974939089;4000.8199631017255;4002.0195052212393;4022.879313620596;4030.1939612077117;4049.433079368832;5905.911411328748;5934.287885453773;5935.376785437639;5940.554458415722;5941.851453713519;5695.857603559944;5733.512651424676;5765.97117014429;5767.826965191051;5768.451997060272;5713.085906254979;5744.971275143597;5748.223989761329;5750.223719797774;5767.8558036049435;5421.078416669096;5582.190582365615;5647.983362994701;5659.037963546125;5662.546996240373;5710.685912274865;5780;5784.566157538117;5802.796902108406;5810.4189581041555;5646.3788983212635;5655.406182350794;5662;5664.943350566442;5672.404397538199 02:08:35 INFO - PROCESS | 7912 | |5;yui.html;644.1656710473915;667.7362441835475;671.5634837355719;702.8769965256079;766.6588368176164;12530.937345313283;12911.225326480419;12925.159864608793;12928.676783080416;12929.224246545215;12223.877761222386;12272.07959403044;12282.815757763641;12284.078694097956;12290;644.4425571880313;791.4894892794144;796.044746304434;816.5182542300042;818.6397984886661;811.7524155132683;816.9550674712889;819.778659761864;819.9057108432518;820.4666966471782;860.3074525007366;860.3977215948829;860.711661593367;861.8707193920899;862.482510493705;663.6880666086931;831.0941074229089;863.2101627011277;863.3352318714586;864.1703964194381;621.934696856828;622.8567429491197;623.0498489803041;623.2520974830222;623.4357906094991;12522.311272879988;12629;12664.493420263178;12703.74592508154;12740.235585864877;11993.820092698617;12421.1926224796;12423.503059877594;12444.937775311066;12545.31000794956;9731.659391921248;9737.756556086084;9797.118259356692;9990.650327238585;10009.84985225215;3257.657945915692;3311.4867195584725;3386.915327116817;3404.6254911959663;3409.9318013639836;42483.57516424827;42817.57182428167;43037.78481107575;43097.13805723899;43783.562164378585;9774.902250977542;9807.852882206773;10244.53899574521;10348.844767328495;10367.377957322586;17601.207945642476;17612.91193544024;17785.9328440294;17820.821791782175;17851.28594856217;6814.352636499525;6916.066331045345;6941.965290173517;7031.296870312928;7148.499605027702;3816.751911125768;3886;3923.843046278117;3936.389859571771;4048.21059893318;2888.8988885388912;2904.9273768155967;2923.751481124128;2924.532074868011;2939.191722276348;525.6241787122226;559.7788873395068;578.2713780636428;581.1225050174268;582.0570675505708;544.5534661577548;566.4562020460322;576.3688760806909;584.8537865533617;588.5674029588249;7141.9285807142305;7480.962595186989;7499.175090740015;7638.390092879257;8121.187881211949;439.13271289204204;475.4651017605194;577.6158854361802;579.2527639345282;595.2291782142137;3561.1809283864854;3570.839312230956;3642.1805093853673;3687.539057617798;3722.441633754904;52723.20915186275;53200.73399633054;53250.733746331796;53409.46590534045;53537.46462535403;45393.546064539594;46430.76784616123;46674.29988550174;47220;47448.762756186;41919.161616767495;42336.36495452571;42932.14135717331;42970.1405971885;43246.56753432488;7184.8922266165;7294.323940103863;7426.257374262531;7429.7399591014055;7448.9627551861895;31730.682693172774;32264.677353227107;32702.182445438102;32832.343353133285;33003.339933201685;36770.816145919096;36973.26053478861;38008;41292.1741565173;41407.585924140374;9284.860727088964;9436.575354108943;9493.797319163177;9957.302988790716;9976.351537150062;10541.736456588647;10711.94644026806;10739.624113156002;10785.89214107849;11265.26775759573;10406.323588966692;10530.84160742333;10539.209559282932;10777.083947864206;10777.13782897382;10469.213465251889;10519.73700657459;10586.364818110938;10866.348019118877;11167.218294719292;10253.794924101625;10280.126189273995;10652.57389704403;10730.839037414602;10869.130469562258;9033.277337812828;9300.255979521757;9386.389884657476;9400.435973841591;9453.527323633929;8574.871376929475;8780.9360206142;9000.279977601907;9111.253993650045;9308.767280818034 02:08:35 INFO - PROCESS | 7912 | __end_tp_report 02:08:35 INFO - PROCESS | 7912 | __start_cc_report 02:08:35 INFO - PROCESS | 7912 | _x_x_mozilla_cycle_collect,1017 02:08:35 INFO - PROCESS | 7912 | __end_cc_report 02:08:35 INFO - PROCESS | 7912 | __startTimestamp1458292115127__endTimestamp 02:08:35 INFO - PROCESS | 7912 | 02:08:35 INFO - PROCESS | 7912 | ------- Summary: start ------- 02:08:35 INFO - PROCESS | 7912 | Number of tests: 6 02:08:35 INFO - PROCESS | 7912 | 02:08:35 INFO - PROCESS | 7912 | [#0] dojo.html Cycles:165 Average:4684.46 Median:4825.61 stddev:492.12 (10.2%) stddev-sans-first:465.97 02:08:35 INFO - PROCESS | 7912 | Values: 2610.9 2673.4 2689.3 2702.6 2725.1 4648.7 4700.2 4712.4 4725.6 4777.2 4662.9 4699.0 4699.6 4701.2 4745.3 4263.1 4337.7 4346.2 4406.4 4441.2 4273.4 4368.4 4419.6 4438.3 4442.6 4287.3 4325.2 4335.2 4350.7 4389.5 4346.1 4351.0 4364.6 4380.9 4389.5 4274.4 4330.9 4339.4 4344.9 4391.9 4585.1 4660.3 4690.1 4691.6 4694.9 5014.8 5027.5 5036.1 5038.3 5080.7 4995.9 5054.9 5074.5 5076.0 5081.8 4701.1 4733.4 4765.9 4803.0 4810.7 5223.6 5231.7 5236.4 5238.7 5247.3 4871.3 4940.1 5026.5 5034.5 5067.2 5038.7 5115.2 5136.4 5141.8 5161.8 5042.3 5052.8 5055.5 5059.1 5102.3 4937.9 5029.2 5041.2 5045.5 5046.9 4156.7 4185.9 4195.3 4202.5 4202.9 3684.6 3727.4 3763.0 3771.7 3812.0 4401.1 4401.3 4404.3 4427.6 4458.6 4942.1 5128.0 5130.1 5130.8 5133.4 4324.4 4388.8 4391.6 4412.9 4431.6 4481.6 4508.4 4520.8 4548.9 4556.2 4722.5 4783.1 4783.1 4790.5 4792.1 5067.0 5081.3 5096.9 5118.3 5149.7 4838.0 4840.2 4845.1 4849.4 4899.2 4936.4 4944.5 5028.2 5062.0 5078.1 5077.9 5088.5 5094.0 5100.7 5138.0 4951.4 4952.6 4953.8 4956.8 4995.4 4825.6 4894.7 4974.8 4995.8 5006.9 4836.5 4853.4 4856.1 4889.9 4904.8 4922.0 4941.8 4947.9 4950.0 4996.2 4766.8 4772.3 4854.2 4874.8 4879.0 02:08:35 INFO - PROCESS | 7912 | 02:08:35 INFO - PROCESS | 7912 | [#1] ext.html Cycles:180 Average:44908.36 Median:19025.78 stddev:76965.17 (404.5%) stddev-sans-first:77108.99 02:08:35 INFO - PROCESS | 7912 | Values: 544.7 556.7 565.5 582.1 601.9 27396.6 36163.6 36168.6 36299.0 36339.0 39412.0 39868.8 39924.4 39952.6 40029.4 7651.4 7822.1 7822.6 7825.3 7827.8 7458.4 7709.2 7820.6 7824.4 7825.6 7477.3 7482.9 7486.0 7487.0 7487.1 7320.9 7703.8 7724.3 7749.8 7805.0 7310.2 7320.8 7342.4 7379.4 7429.0 38492.0 38928.6 39062.4 39092.0 39095.4 3137.9 3306.2 3453.6 3632.1 3742.2 29183.6 29272.6 29670.3 29826.7 29885.0 3137.7 3155.6 3190.0 3287.4 3380.1 245095.0 246712.0 247275.0 248590.0 248634.0 61130.0 61332.4 61347.0 61412.7 61465.7 65043.0 65366.0 65945.0 65990.3 66085.3 13469.3 13577.4 13603.7 13619.9 13656.1 10364.6 10407.1 10424.8 10426.3 10432.3 19235.6 19463.0 19528.6 19571.2 19581.0 7835.5 7955.6 8008.2 8123.2 8177.4 841.6 928.9 934.5 939.7 962.7 27671.2 27720.6 28058.7 28261.7 28542.1 1020.7 1042.8 1046.7 1052.9 1115.5 14439.8 14599.2 14868.5 14877.2 15582.9 365258.0 374976.0 377200.0 377965.0 378316.0 52189.0 52818.7 52856.0 52919.7 52961.7 1157.5 1166.7 1233.9 1278.2 1289.4 25411.4 26942.2 27526.3 27652.3 28327.2 39690.0 40217.2 40376.8 40685.8 40687.4 227883.0 236059.0 236392.0 236582.0 236752.0 27319.7 31919.8 32229.8 32482.8 32646.2 38495.2 38733.0 39420.2 39802.8 40231.0 32607.8 33836.0 34598.0 34751.0 34812.3 33473.8 34131.8 34191.3 34266.8 34288.5 33503.7 33710.3 34024.8 34314.3 34324.3 29254.0 29979.4 30298.2 30358.2 30387.2 23927.4 24010.0 24051.8 24228.5 24301.9 02:08:35 INFO - PROCESS | 7912 | 02:08:35 INFO - PROCESS | 7912 | [#2] jquery.html Cycles:180 Average:23812.07 Median:5021.65 stddev:68082.42 (1355.8%) stddev-sans-first:68250.63 02:08:35 INFO - PROCESS | 7912 | Values: 357.2 360.6 366.8 371.5 374.2 15188.4 15307.4 16359.9 16397.0 16407.9 15679.0 15871.2 16780.5 16796.2 16798.3 4928.3 5000.2 5155.1 5155.7 5160.0 5110.0 5124.6 5135.2 5142.2 5159.8 4958.5 5043.1 5056.2 5092.8 5102.9 5043.8 5098.7 5102.3 5104.0 5111.7 4574.4 4581.0 4582.9 4583.2 4586.4 18271.7 19233.6 19262.7 19271.4 19308.2 1905.1 1914.9 1915.7 1936.6 1938.1 12067.2 12344.8 12362.6 12728.7 12787.5 1723.5 1775.1 1863.4 1868.8 1925.3 45082.5 51874.7 52180.0 55211.7 59768.4 9544.8 9611.6 9639.8 9664.7 9823.6 11420.1 12260.1 12328.6 12424.8 12463.8 6794.3 6930.3 7206.4 7210.5 7219.0 6513.1 6683.2 6744.0 6867.6 6879.3 5789.9 5888.6 5907.3 5919.3 5995.5 1737.7 1759.2 1761.8 1781.7 1786.4 876.8 899.6 951.3 967.0 999.0 16050.1 16348.3 16744.7 16765.0 17030.0 860.9 882.9 901.7 909.2 946.8 9409.2 9465.3 9509.5 9720.8 9770.8 408498.0 412740.0 414638.0 415443.0 431592.0 60993.0 61078.7 62078.0 62669.7 62919.7 943.6 959.3 960.3 968.2 976.5 14418.9 14695.9 14755.8 14788.1 14821.2 34468.0 35533.0 35656.1 36714.0 36718.0 42946.6 45930.5 45969.3 46265.8 46276.1 7084.5 7258.5 7297.5 7339.9 7430.9 8378.8 10658.5 10975.3 11365.5 11409.9 9340.7 9881.9 9888.4 10142.3 10320.1 9506.9 9653.9 9806.6 9902.7 10027.1 9596.3 9860.9 9953.6 10112.2 10283.3 7330.3 7445.1 7485.3 7485.6 7546.5 7941.8 9470.7 10323.8 10506.5 10549.3 02:08:35 INFO - PROCESS | 7912 | 02:08:35 INFO - PROCESS | 7912 | [#3] mootools.html Cycles:180 Average:5452.76 Median:6342.91 stddev:2819.93 (44.5%) stddev-sans-first:2810.49 02:08:35 INFO - PROCESS | 7912 | Values: 1291.8 1436.9 1458.7 1623.6 1816.4 7398.1 7614.8 7632.6 7642.5 7644.0 7492.1 7661.8 7686.0 7699.5 7703.5 1922.3 1969.7 1972.9 2302.9 2339.1 2257.5 2313.8 2315.1 2315.2 2316.7 2250.1 2252.7 2257.1 2257.1 2343.9 2236.6 2258.6 2263.3 2266.0 2266.5 2318.5 2329.8 2330.1 2331.7 2332.2 7641.1 7692.1 7698.9 7706.3 7716.2 4734.3 4837.9 4848.4 4861.5 4864.5 3010.9 3068.1 3204.2 3235.9 3237.8 993.4 1004.2 1027.1 1039.8 1062.5 10729.0 10745.0 10760.4 10770.1 10788.1 4477.4 4512.5 4603.9 4606.5 4606.7 9111.0 9144.2 9144.6 9157.5 9184.6 4866.2 4879.8 4884.0 4884.6 4885.0 3740.9 4259.5 4366.8 4402.2 4404.9 3800.9 3874.9 3876.3 3900.2 3934.7 1269.2 1289.2 1292.9 1300.4 1305.9 1194.2 1199.9 1209.7 1220.1 1225.2 7106.6 7163.8 7222.9 7224.1 7309.6 1061.6 1064.8 1071.2 1078.4 1104.5 5258.2 5269.6 5338.0 5339.3 5348.7 9358.7 9366.5 9617.1 9652.5 9655.5 9533.8 9574.9 9594.3 9627.6 9637.4 7254.3 7354.7 7399.3 7473.4 7479.5 6976.8 7035.0 7035.1 7040.1 7068.8 8384.2 8493.6 8597.5 8630.0 8631.4 8649.6 8900.3 9026.0 9030.6 9069.9 6255.5 6340.1 6345.7 6355.7 6394.4 7317.3 7345.3 7383.4 7428.8 7468.6 6665.2 6778.1 6834.5 6921.1 6956.1 6616.7 6628.0 6636.9 6706.7 6721.2 6799.7 6846.2 6875.2 6881.6 7014.5 6413.8 6415.6 6463.5 6471.6 6474.0 6404.0 6441.8 6454.7 6456.5 6458.5 02:08:35 INFO - PROCESS | 7912 | 02:08:35 INFO - PROCESS | 7912 | [#4] prototype.html Cycles:180 Average:4744.85 Median:5348.79 stddev:1396.95 (26.1%) stddev-sans-first:1360.94 02:08:35 INFO - PROCESS | 7912 | Values: 326.4 327.5 327.5 331.4 333.5 5319.7 5349.0 5357.5 5414.8 5450.6 5303.2 5333.5 5337.3 5345.4 5348.6 4016.3 4110.6 4197.0 4200.1 4224.5 4187.8 4201.1 4201.7 4209.6 4209.7 4160.7 4201.7 4206.2 4208.9 4210.3 3958.6 4054.4 4135.7 4176.7 4183.4 3689.1 3700.2 3701.6 3705.1 3712.6 5154.7 5166.3 5171.9 5175.8 5176.9 4865.3 4871.2 4873.0 4874.0 4883.4 5689.3 5700.1 5702.6 5704.8 5728.7 3975.6 4072.9 4082.7 4087.2 4087.8 5936.1 5991.7 5998.2 5999.6 6033.7 4165.7 4181.9 4184.8 4194.9 4195.8 4241.6 4244.0 4246.0 4246.7 4250.5 4794.5 4815.4 4819.3 4822.3 4825.0 5701.2 5707.9 5721.5 5736.7 5742.3 1401.9 1482.5 1506.5 1506.5 1512.0 913.5 957.3 962.3 973.5 979.5 4933.8 4951.8 4959.2 4962.6 4964.4 5829.5 5830.5 5836.8 5837.2 5840.6 4939.8 4948.8 4950.2 4962.7 4963.8 3099.9 3146.1 3146.7 3148.9 3153.5 5548.1 5554.1 5556.1 5561.9 5562.4 5917.2 6172.8 6173.5 6181.4 6183.7 5660.5 5689.9 5691.6 5692.2 5698.9 5975.2 5978.5 5980.8 5983.3 5983.8 5866.8 5870.2 5871.5 5874.4 5875.4 5442.8 5671.6 5679.8 5688.3 5691.1 4000.8 4002.0 4022.9 4030.2 4049.4 5905.9 5934.3 5935.4 5940.6 5941.9 5695.9 5733.5 5766.0 5767.8 5768.5 5713.1 5745.0 5748.2 5750.2 5767.9 5421.1 5582.2 5648.0 5659.0 5662.5 5710.7 5780.0 5784.6 5802.8 5810.4 5646.4 5655.4 5662.0 5664.9 5672.4 02:08:35 INFO - PROCESS | 7912 | 02:08:35 INFO - PROCESS | 7912 | [#5] yui.html Cycles:180 Average:12705.28 Median:45912.16 stddev:14490.08 (31.6%) stddev-sans-first:14502.42 02:08:35 INFO - PROCESS | 7912 | Values: 644.2 667.7 671.6 702.9 766.7 12530.9 12911.2 12925.2 12928.7 12929.2 12223.9 12272.1 12282.8 12284.1 12290.0 644.4 791.5 796.0 816.5 818.6 811.8 817.0 819.8 819.9 820.5 860.3 860.4 860.7 861.9 862.5 663.7 831.1 863.2 863.3 864.2 621.9 622.9 623.0 623.3 623.4 12522.3 12629.0 12664.5 12703.7 12740.2 11993.8 12421.2 12423.5 12444.9 12545.3 9731.7 9737.8 9797.1 9990.7 10009.8 3257.7 3311.5 3386.9 3404.6 3409.9 42483.6 42817.6 43037.8 43097.1 43783.6 9774.9 9807.9 10244.5 10348.8 10367.4 17601.2 17612.9 17785.9 17820.8 17851.3 6814.4 6916.1 6942.0 7031.3 7148.5 3816.8 3886.0 3923.8 3936.4 4048.2 2888.9 2904.9 2923.8 2924.5 2939.2 525.6 559.8 578.3 581.1 582.1 544.6 566.5 576.4 584.9 588.6 7141.9 7481.0 7499.2 7638.4 8121.2 439.1 475.5 577.6 579.3 595.2 3561.2 3570.8 3642.2 3687.5 3722.4 52723.2 53200.7 53250.7 53409.5 53537.5 45393.5 46430.8 46674.3 47220.0 47448.8 41919.2 42336.4 42932.1 42970.1 43246.6 7184.9 7294.3 7426.3 7429.7 7449.0 31730.7 32264.7 32702.2 32832.3 33003.3 36770.8 36973.3 38008.0 41292.2 41407.6 9284.9 9436.6 9493.8 9957.3 9976.4 10541.7 10711.9 10739.6 10785.9 11265.3 10406.3 10530.8 10539.2 10777.1 10777.1 10469.2 10519.7 10586.4 10866.3 11167.2 10253.8 10280.1 10652.6 10730.8 10869.1 9033.3 9300.3 9386.4 9400.4 9453.5 8574.9 8780.9 9000.3 9111.3 9308.8 02:08:35 INFO - PROCESS | 7912 | -------- Summary: end -------- 02:08:35 INFO - PROCESS | 7912 | 02:08:35 INFO - TEST-INFO | 7912: exit 0 02:08:35 INFO - TEST-OK | dromaeo_css | took 1115613ms 02:08:35 INFO - TEST-START | kraken 02:08:35 INFO - operating with platform_type : linux_ 02:08:35 INFO - Initialising browser for kraken test... 02:08:35 INFO - TEST-INFO | started process 8088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvcvRRg/profile http://localhost:55088/getInfo.html) 02:08:39 INFO - PROCESS | 8088 | __metrics Screen width/height:1600/1200 02:08:39 INFO - PROCESS | 8088 | colorDepth:24 02:08:39 INFO - PROCESS | 8088 | Browser inner width/height: 1024/697 02:08:39 INFO - PROCESS | 8088 | __metrics 02:08:40 ERROR - PROCESS | 8088 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:08:41 INFO - TEST-INFO | 8088: exit 0 02:08:41 INFO - Browser initialized. 02:08:41 INFO - Running cycle 1/1 for kraken test... 02:08:41 INFO - TEST-INFO | started process 8168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvcvRRg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:53 INFO - PROCESS | 8168 | RSS: Main: 154943488 02:08:53 INFO - PROCESS | 8168 | 02:08:55 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55088/tests/kraken/driver.html?testName=audio-beat-detection) 02:08:56 INFO - PROCESS | 8168 | RSS: Main: 198033408 02:08:56 INFO - PROCESS | 8168 | 02:08:59 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55088/tests/kraken/driver.html?testName=audio-dft) 02:08:59 INFO - PROCESS | 8168 | RSS: Main: 188059648 02:08:59 INFO - PROCESS | 8168 | 02:09:02 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55088/tests/kraken/driver.html?testName=audio-fft) 02:09:03 INFO - PROCESS | 8168 | RSS: Main: 172781568 02:09:03 INFO - PROCESS | 8168 | 02:09:05 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55088/tests/kraken/driver.html?testName=audio-oscillator) 02:09:05 INFO - PROCESS | 8168 | RSS: Main: 175300608 02:09:05 INFO - PROCESS | 8168 | 02:09:08 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55088/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:09:08 INFO - PROCESS | 8168 | RSS: Main: 176558080 02:09:08 INFO - PROCESS | 8168 | 02:09:11 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55088/tests/kraken/driver.html?testName=imaging-darkroom) 02:09:12 INFO - PROCESS | 8168 | RSS: Main: 176922624 02:09:12 INFO - PROCESS | 8168 | 02:09:15 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55088/tests/kraken/driver.html?testName=imaging-desaturate) 02:09:16 INFO - PROCESS | 8168 | RSS: Main: 176201728 02:09:16 INFO - PROCESS | 8168 | 02:09:19 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55088/tests/kraken/driver.html?testName=json-parse-financial) 02:09:19 INFO - PROCESS | 8168 | RSS: Main: 177053696 02:09:19 INFO - PROCESS | 8168 | 02:09:21 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55088/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:09:22 INFO - PROCESS | 8168 | RSS: Main: 186793984 02:09:22 INFO - PROCESS | 8168 | 02:09:23 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:09:24 INFO - PROCESS | 8168 | RSS: Main: 184229888 02:09:24 INFO - PROCESS | 8168 | 02:09:26 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:09:27 INFO - PROCESS | 8168 | RSS: Main: 193306624 02:09:27 INFO - PROCESS | 8168 | 02:09:29 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:09:30 INFO - PROCESS | 8168 | RSS: Main: 199249920 02:09:30 INFO - PROCESS | 8168 | 02:09:32 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:09:33 INFO - PROCESS | 8168 | RSS: Main: 199720960 02:09:33 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55088/tests/kraken/driver.html?testName=ai-astar) 02:09:35 INFO - PROCESS | 8168 | RSS: Main: 258859008 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | __start_tp_report 02:09:35 INFO - PROCESS | 8168 | _x_x_mozilla_page_load 02:09:35 INFO - PROCESS | 8168 | _x_x_mozilla_page_load_details 02:09:35 INFO - PROCESS | 8168 | |i|pagename|runs| 02:09:35 INFO - PROCESS | 8168 | |0;ai-astar;111;115;107;111;111;112;101;111;110;112 02:09:35 INFO - PROCESS | 8168 | |1;audio-beat-detection;151;129;151;176;132;153;153;131;186;135 02:09:35 INFO - PROCESS | 8168 | |2;audio-dft;161;161;162;160;160;160;163;162;163;161 02:09:35 INFO - PROCESS | 8168 | |3;audio-fft;74;73;103;94;74;73;72;109;95;75 02:09:35 INFO - PROCESS | 8168 | |4;audio-oscillator;94;93;142;92;94;93;130;94;93;129 02:09:35 INFO - PROCESS | 8168 | |5;imaging-gaussian-blur;117;117;119;118;119;117;117;117;117;117 02:09:35 INFO - PROCESS | 8168 | |6;imaging-darkroom;147;147;146;146;146;146;147;146;147;147 02:09:35 INFO - PROCESS | 8168 | |7;imaging-desaturate;95;95;95;96;95;96;95;96;96;95 02:09:35 INFO - PROCESS | 8168 | |8;json-parse-financial;65;64;71;65;65;64;65;73;64;63 02:09:35 INFO - PROCESS | 8168 | |9;json-stringify-tinderbox;64;64;65;65;64;64;65;65;65;64 02:09:35 INFO - PROCESS | 8168 | |10;stanford-crypto-aes;81;81;82;83;82;81;81;82;81;82 02:09:35 INFO - PROCESS | 8168 | |11;stanford-crypto-ccm;115;117;124;123;127;117;124;121;129;120 02:09:35 INFO - PROCESS | 8168 | |12;stanford-crypto-pbkdf2;138;137;140;138;147;133;139;139;140;139 02:09:35 INFO - PROCESS | 8168 | |13;stanford-crypto-sha256-iterative;65;66;68;65;66;68;68;65;64;68 02:09:35 INFO - PROCESS | 8168 | __end_tp_report 02:09:35 INFO - PROCESS | 8168 | __start_cc_report 02:09:35 INFO - PROCESS | 8168 | _x_x_mozilla_cycle_collect,1128 02:09:35 INFO - PROCESS | 8168 | __end_cc_report 02:09:35 INFO - PROCESS | 8168 | __startTimestamp1458292175436__endTimestamp 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | ------- Summary: start ------- 02:09:35 INFO - PROCESS | 8168 | Number of tests: 14 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.75 (3.4%) stddev-sans-first:3.97 02:09:35 INFO - PROCESS | 8168 | Values: 111.0 115.0 107.0 111.0 111.0 112.0 101.0 111.0 110.0 112.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:152.00 stddev:19.27 (12.7%) stddev-sans-first:20.43 02:09:35 INFO - PROCESS | 8168 | Values: 151.0 129.0 151.0 176.0 132.0 153.0 153.0 131.0 186.0 135.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 02:09:35 INFO - PROCESS | 8168 | Values: 161.0 161.0 162.0 160.0 160.0 160.0 163.0 162.0 163.0 161.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#3] audio-fft Cycles:10 Average:84.20 Median:74.00 stddev:14.43 (19.5%) stddev-sans-first:14.82 02:09:35 INFO - PROCESS | 8168 | Values: 74.0 73.0 103.0 94.0 74.0 73.0 72.0 109.0 95.0 75.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:93.00 stddev:19.81 (21.3%) stddev-sans-first:20.58 02:09:35 INFO - PROCESS | 8168 | Values: 94.0 93.0 142.0 92.0 94.0 93.0 130.0 94.0 93.0 129.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 02:09:35 INFO - PROCESS | 8168 | Values: 117.0 117.0 119.0 118.0 119.0 117.0 117.0 117.0 117.0 117.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:09:35 INFO - PROCESS | 8168 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:09:35 INFO - PROCESS | 8168 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:3.31 (5.1%) stddev-sans-first:3.50 02:09:35 INFO - PROCESS | 8168 | Values: 65.0 64.0 71.0 65.0 65.0 64.0 65.0 73.0 64.0 63.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 02:09:35 INFO - PROCESS | 8168 | Values: 64.0 64.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 64.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 02:09:35 INFO - PROCESS | 8168 | Values: 81.0 81.0 82.0 83.0 82.0 81.0 81.0 82.0 81.0 82.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:123.50 stddev:4.55 (3.7%) stddev-sans-first:4.13 02:09:35 INFO - PROCESS | 8168 | Values: 115.0 117.0 124.0 123.0 127.0 117.0 124.0 121.0 129.0 120.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:139.00 stddev:3.46 (2.5%) stddev-sans-first:3.66 02:09:35 INFO - PROCESS | 8168 | Values: 138.0 137.0 140.0 138.0 147.0 133.0 139.0 139.0 140.0 139.0 02:09:35 INFO - PROCESS | 8168 | 02:09:35 INFO - PROCESS | 8168 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.57 (2.3%) stddev-sans-first:1.59 02:09:35 INFO - PROCESS | 8168 | Values: 65.0 66.0 68.0 65.0 66.0 68.0 68.0 65.0 64.0 68.0 02:09:35 INFO - PROCESS | 8168 | -------- Summary: end -------- 02:09:35 INFO - PROCESS | 8168 | 02:09:36 INFO - TEST-INFO | 8168: exit 0 02:09:36 INFO - TEST-OK | kraken | took 60550ms 02:09:36 INFO - SUITE-END | took 1176s 02:09:36 INFO - Completed test suite (00:19:36) 02:09:36 INFO - javascript benchmark 02:09:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2610.9216723498294, 2673.3984853407987, 2689.287338855205, 2702.594610808377, 2725.1143378402016, 4648.65135114866, 4700.200965835807, 4712.434507859058, 4725.598324142447, 4777.235642297233, 4662.930056049154, 4698.976505117478, 4699.600533954609, 4701.153792317382, 4745.335653008581, 4263.083437061031, 4337.696361254713, 4346.174226896879, 4406.427164468614, 4441.178381999324, 4273.444452221207, 4368.410264614284, 4419.558044195587, 4438.26768583185, 4442.600165985061, 4287.3140297552245, 4325.178216138924, 4335.241332766785, 4350.6736994725525, 4389.495208051051, 4346.065595896897, 4350.956490435086, 4364.585364390377, 4380.934285985712, 4389.5390983946545, 4274.358846173068, 4330.9389199645975, 4339.435873336446, 4344.869653910388, 4391.934120988188, 4585.060062687141, 4660.277656963176, 4690.132325519789, 4691.6481263905, 4694.929576056362, 5014.799408023711, 5027.49725027498, 5036.143855544529, 5038.294638750578, 5080.695158290478, 4995.8501244962345, 5054.898902021939, 5074.467180945984, 5076.035553244872, 5081.79672813087, 4701.130290896195, 4733.360996265529, 4765.904681906342, 4803.03939212159, 4810.735409552508, 5223.634345595772, 5231.738413079331, 5236.39781425141, 5238.73806309683, 5247.317848679647, 4871.29366241893, 4940.135476291634, 5026.4973502649445, 5034.521720436553, 5067.214581739836, 5038.748062596929, 5115.2071428928575, 5136.43499215086, 5141.820036298712, 5161.793528258828, 5042.319286896295, 5052.8484145475695, 5055.545000949932, 5059.06407314648, 5102.285680004802, 4937.925931111036, 5029.1953287473825, 5041.218611115283, 5045.470225626256, 5046.914913293659, 4156.708094327643, 4185.916281674349, 4195.265828480004, 4202.537720850704, 4202.873913782591, 3684.631536846294, 3727.4408838674417, 3762.962370376316, 3771.6982641389172, 3811.9809400952818, 4401.1417773534495, 4401.295792673157, 4404.2512772828695, 4427.579379958963, 4458.598726114666, 4942.1104201244125, 5127.974360128175, 5130.127878260705, 5130.769115389742, 5133.435322114565, 4324.416203812445, 4388.846390376321, 4391.626711729475, 4412.911741765147, 4431.623312018514, 4481.551844815557, 4508.436445444319, 4520.751358675238, 4548.863534093983, 4556.24821904382, 4722.456917454399, 4783.091212669582, 4783.115123702126, 4790.544898234802, 4792.113459010095, 5066.974665126798, 5081.288619593186, 5096.872578185575, 5118.33461649998, 5149.716765577779, 4838.032393521239, 4840.201366774443, 4845.1278769820365, 4849.393825771778, 4899.216125420058, 4936.432310284364, 4944.505549445027, 5028.170351891897, 5061.974690126526, 5078.136716758087, 5077.8730531737, 5088.54203121706, 5094.0, 5100.719460429564, 5138.0, 4951.3810773653295, 4952.5542701157065, 4953.777080031336, 4956.77694503741, 4995.425526064549, 4825.6139508839915, 4894.681845680019, 4974.801007959641, 4995.775190116527, 5006.924896126488, 4836.492168322276, 4853.417589889236, 4856.077345304381, 4889.853304400874, 4904.779284932258, 4922.040202160544, 4941.825834888724, 4947.925781113358, 4949.975250123726, 4996.175631020841, 4766.833160839493, 4772.284157376283, 4854.2233242681, 4874.805007799649, 4878.975605121952], "unit": "score", "name": "dojo.html", "value": 4653.249089511877}, {"lowerIsBetter": false, "replicates": [544.7194694732212, 556.6854727079198, 565.5447364871279, 582.1122787748683, 601.9398060193981, 27396.589051164225, 36163.63836361636, 36168.63831361686, 36299.0, 36339.0, 39412.0, 39868.80065599668, 39924.40113398294, 39952.60047399525, 40029.39955900657, 7651.426143039266, 7822.139564647884, 7822.647980840848, 7825.256600622932, 7827.804304892366, 7458.366038886674, 7709.190534993829, 7820.648070836826, 7824.374050076009, 7825.591393549159, 7477.252274772533, 7482.9251707483045, 7486.0, 7486.962565187167, 7487.064116985377, 7320.853582928312, 7703.807404814925, 7724.266194711549, 7749.806254843617, 7805.0, 7310.195878453366, 7320.828667413241, 7342.375898048672, 7379.3727533159745, 7429.034225550698, 38492.0, 38928.610713892784, 39062.41406378907, 39092.0, 39095.41356879649, 3137.905862824119, 3306.173456635841, 3453.568303962005, 3632.0919770057485, 3742.2328422673286, 29183.562246566107, 29272.572291649005, 29670.258243543867, 29826.70173298261, 29885.0, 3137.7332926701256, 3155.637101733307, 3189.9681003189903, 3287.4247006773717, 3380.053584996205, 245095.0, 246712.0, 247275.0, 248590.0, 248634.0, 61130.0, 61332.386676132664, 61347.0, 61412.69293653503, 61465.692671537254, 65043.0, 65366.0, 65945.0, 65990.34009659938, 66085.33914660888, 13469.259190744408, 13577.389017494237, 13603.727925441633, 13619.863801362058, 13656.112352697042, 10364.637237696796, 10407.06336429725, 10424.843627345595, 10426.270161088803, 10432.2697411182, 19235.615287694167, 19463.03393768494, 19528.558930133735, 19571.217151313787, 19581.0, 7835.451518393657, 7955.641996110189, 8008.239217274349, 8123.228293312126, 8177.427580069338, 841.5792103948025, 928.8653145293895, 934.4860326820358, 939.6664184214505, 962.7208109648124, 27671.169864904085, 27720.584191237147, 28058.71941280602, 28261.717382825907, 28542.14373568796, 1020.6529779874878, 1042.8122937871256, 1046.6546039806997, 1052.921030922684, 1115.4757264085868, 14439.783403248959, 14599.19704416246, 14868.479603214051, 14877.18175500358, 15582.9220853895, 365258.0, 374976.0, 377200.0, 377965.0, 378316.0, 52188.95622087537, 52818.735906320224, 52856.0, 52919.735401322745, 52961.735191323794, 1157.4964890272759, 1166.6966588687003, 1233.9259644421363, 1278.1947373154853, 1289.3617659258728, 25411.36471588225, 26942.191734248005, 27526.311842204104, 27652.308692282048, 28327.15018549447, 39690.0, 40217.1956560873, 40376.79811600923, 40685.79657101695, 40687.38968915409, 227883.0, 236059.0, 236392.0, 236582.0, 236752.0, 27319.72680273172, 31919.840400797846, 32229.838850805594, 32482.837585811918, 32646.183845404055, 38495.230095398496, 38733.0, 39420.21159576735, 39802.80098599489, 40231.0, 32607.836960815992, 33836.0, 34598.0, 34751.0, 34812.303753925284, 33473.83263083669, 34131.82934085413, 34191.31617367688, 34266.82866585651, 34288.48567271443, 33503.704584175364, 33710.32579348448, 34024.82987585046, 34314.31371372509, 34324.313513730085, 29254.0, 29979.400411992076, 30298.24254393658, 30358.241043973194, 30387.240318991317, 23927.401814954766, 24010.0, 24051.759482404952, 24228.515429690953, 24301.878490607432], "unit": "score", "name": "ext.html", "value": 17446.90141462332}, {"lowerIsBetter": false, "replicates": [357.19452634309613, 360.63395653411794, 366.75060958548187, 371.5188830464548, 374.1917458290094, 15188.392464301429, 15307.38770449182, 16359.918200408982, 16397.0, 16407.851450398462, 15679.0, 15871.206439678028, 16780.496585102435, 16796.244169012392, 16798.32806687734, 4928.334674818907, 5000.224965130402, 5155.123628983082, 5155.71643559604, 5160.045391602547, 5109.974450127745, 5124.564412024983, 5135.2297155426795, 5142.151544995071, 5159.819406320779, 4958.528939750718, 5043.084620577375, 5056.165732654108, 5092.79628814847, 5102.897942041175, 5043.848684539433, 5098.668586541863, 5102.336696229503, 5104.0, 5111.744412779365, 4574.359589657451, 4580.992181720049, 4582.885427864297, 4583.220852455057, 4586.449626044896, 18271.72592411115, 19233.61532769337, 19262.71105933412, 19271.421857344303, 19308.227670893146, 1905.1141219332937, 1914.9138288777037, 1915.7030660247544, 1936.564273038555, 1938.1472152252963, 12067.215630984047, 12344.81482777759, 12362.629121126382, 12728.74542509154, 12787.488500459971, 1723.4571110100278, 1775.0947017021283, 1863.413024897153, 1868.7757469103658, 1925.3261358524544, 45082.54917450816, 51874.740626297, 52180.0, 55211.723941380435, 59768.40231597715, 9544.809103817885, 9611.615535378507, 9639.759006024906, 9664.661736839318, 9823.557939892722, 11420.14348923834, 12260.080493962989, 12328.630141095782, 12424.75150497003, 12463.75072498545, 6794.286599906938, 6930.341617546325, 7206.387457066103, 7210.459215558749, 7219.0, 6513.055606936968, 6683.164604424447, 6743.966280168568, 6867.553609015398, 6879.346462086094, 5789.913151302734, 5888.587798854125, 5907.32065812437, 5919.3192782829665, 5995.52035837132, 1737.6611560745532, 1759.1556053094587, 1761.8414342709218, 1781.7238328059173, 1786.44497450076, 876.7588913048835, 899.595182168027, 951.2770294576034, 966.990330096704, 998.9750256243507, 16050.117243551484, 16348.264328105264, 16744.748828767577, 16765.0, 17030.0, 860.8794768732382, 882.9161229683169, 901.6618767962015, 909.2271569166156, 946.8011717539256, 9409.200217981548, 9465.337426380225, 9509.524523773784, 9720.805583888283, 9770.755731106638, 408498.0, 412740.0, 414638.0, 415443.0, 431592.0, 60993.0, 61078.69460652668, 62078.0, 62669.68665156645, 62919.6854015727, 943.556528431636, 959.2517836087862, 960.2989817433313, 968.1673760565908, 976.4824642939253, 14418.927905360406, 14695.853041469449, 14755.778663320274, 14788.11271323724, 14821.184834834188, 34468.0, 35533.0, 35656.108597285274, 36714.0, 36718.0, 42946.570534295504, 45930.54069459263, 45969.31046034245, 46265.76867115643, 46276.07447850957, 7084.46866485026, 7258.491905566771, 7297.525660832029, 7339.926600733925, 7430.851382972419, 8378.790530236793, 10658.467076645982, 10975.341479510935, 11365.48855301497, 11409.942950285196, 9340.673076442563, 9881.901180988098, 9888.406695598287, 10142.29003969715, 10320.071193592312, 9506.90493095088, 9653.9034609653, 9806.607735690777, 9902.653407130716, 10027.097561219525, 9596.328257021942, 9860.901390985999, 9953.552090155816, 10112.241581881535, 10283.280170388001, 7330.340269375782, 7445.069366329209, 7485.278385971148, 7485.588292643957, 7546.471746977879, 7941.761747147595, 9470.668526601536, 10323.793524129325, 10506.527206275583, 10549.314294570828], "unit": "score", "name": "jquery.html", "value": 8002.572915837548}, {"lowerIsBetter": false, "replicates": [1291.7803973324533, 1436.8778653814425, 1458.6790906000676, 1623.6265658898453, 1816.4369045595865, 7398.112226532817, 7614.809629759245, 7632.58020808856, 7642.503237289579, 7643.961780191091, 7492.138404083532, 7661.808454788633, 7686.039245094364, 7699.461037727361, 7703.53778773274, 1922.2599299269812, 1969.7045443183565, 1972.8816271023713, 2302.896369663365, 2339.087755775249, 2257.5146343536135, 2313.826463015272, 2315.1202543033623, 2315.2012555668266, 2316.6756654068445, 2250.054976909702, 2252.68462415262, 2257.0633187227363, 2257.0745994142403, 2343.945224648915, 2236.552689462114, 2258.604744169772, 2263.3323169664823, 2266.048259730917, 2266.4787098967163, 2318.4783423729696, 2329.8019668328043, 2330.114556468548, 2331.7318508371586, 2332.24202134307, 7641.121271053845, 7692.076950765888, 7698.884516732253, 7706.306432421053, 7716.228377162239, 4734.26618874075, 4837.927431088537, 4848.369711937426, 4861.538153875376, 4864.464908860023, 3010.8946186883572, 3068.125584208512, 3204.1669166016773, 3235.9352812943607, 3237.7733558650903, 993.4287784523927, 1004.2167109654408, 1027.0705011964185, 1039.828428309328, 1062.5271754069443, 10729.0, 10745.0, 10760.3543787373, 10770.138388928945, 10788.136949044057, 4477.440319960005, 4512.503624601291, 4603.8849028773875, 4606.539346065367, 4606.723596584216, 9110.954445227731, 9144.222741067084, 9144.588493517807, 9157.45055296671, 9184.586693598803, 4866.221404575251, 4879.829205977845, 4884.0476107159475, 4884.5603895649565, 4885.0, 3740.8877733668032, 4259.5101563319995, 4366.825326986885, 4402.229609818333, 4404.933925991113, 3800.8669696560487, 3874.9031274217805, 3876.321643712339, 3900.1614652849776, 3934.7245692801803, 1269.1850653565305, 1289.2457912121513, 1292.883640472362, 1300.4148133340034, 1305.934703264833, 1194.1760185471996, 1199.898008669273, 1209.7157168065673, 1220.1337050693928, 1225.2342286071205, 7106.5736055836815, 7163.785086447415, 7222.855542889113, 7224.060872086595, 7309.634518274065, 1061.6496556136456, 1064.8083344997974, 1071.212658695858, 1078.396098185019, 1104.536094840169, 5258.2375555544995, 5269.55208807248, 5338.039152952429, 5339.279197308391, 5348.679079255257, 9358.719238422858, 9366.531673416303, 9617.086376794194, 9652.517374131265, 9655.517224138765, 9533.761655958657, 9574.856377154349, 9594.328397012281, 9627.56675949584, 9637.42175469474, 7254.274572542704, 7354.749692552172, 7399.260073992666, 7473.364763995121, 7479.476436649491, 6976.825579360557, 7035.0, 7035.085438892911, 7040.119985001875, 7068.823279418056, 8384.245417912418, 8493.617787199468, 8597.484150950962, 8630.0, 8631.352648551509, 8649.56752162402, 8900.287976961958, 9025.954870225607, 9030.63877444895, 9069.909300906906, 6255.530835187288, 6340.112384266298, 6345.714442850175, 6355.713992870239, 6394.360563943568, 7317.341439270491, 7345.3021962913435, 7383.409327253914, 7428.814279643052, 7468.589227592317, 6665.233498147775, 6778.084958530535, 6834.487413444111, 6921.065656136358, 6956.130483689539, 6616.735330586916, 6628.0, 6636.900446493403, 6706.731730730716, 6721.22705888829, 6799.694013769491, 6846.212685541027, 6875.243723190545, 6881.587104773729, 7014.473914456538, 6413.807585772434, 6415.615063096043, 6463.515236357198, 6471.579347342407, 6473.967630161819, 6403.96798016007, 6441.774537891151, 6454.741810327534, 6456.451201647725, 6458.451031662361], "unit": "score", "name": "mootools.html", "value": 4495.155292617976}, {"lowerIsBetter": false, "replicates": [326.35056238086213, 327.464595386543, 327.52999445795285, 331.43159481489226, 333.5030804101887, 5319.654222475537, 5349.0, 5357.464253574641, 5414.810481633143, 5450.618456708032, 5303.178007408848, 5333.466653334664, 5337.252784610148, 5345.4387289334645, 5348.572114230862, 4016.31722607156, 4110.588941105895, 4196.9580304197025, 4200.0969791494745, 4224.493060832704, 4187.811548480326, 4201.117765269282, 4201.70588058836, 4209.6000879916355, 4209.684273679486, 4160.7087503874745, 4201.747895126302, 4206.179794939988, 4208.936865947013, 4210.263203939314, 3958.604139586033, 4054.432379466877, 4135.6898232632675, 4176.728512646669, 4183.435236243099, 3689.1146124929824, 3700.2229531798353, 3701.555813302394, 3705.1478160023344, 3712.573054098786, 5154.742262886878, 5166.276721259027, 5171.896562068738, 5175.844724658266, 5176.870578235536, 4865.34317867087, 4871.171900776876, 4872.975635121802, 4874.0, 4883.413990321149, 5689.288838895138, 5700.087985922274, 5702.572307076985, 5704.77180912763, 5728.68492232927, 3975.6421922026866, 4072.9185416291507, 4082.7346222495444, 4087.2438598859308, 4087.7751723655188, 5936.139259807347, 5991.700414979277, 5998.220231369894, 5999.580029397944, 6033.728482218311, 4165.687573432005, 4181.853635122817, 4184.81168347419, 4194.853180138681, 4195.811188496525, 4241.63946064588, 4244.045089854758, 4246.002189485468, 4246.681498887596, 4250.511191212988, 4794.520547945247, 4815.422149342101, 4819.349387832668, 4822.324874517571, 4825.0, 5701.173329867146, 5707.942920570824, 5721.456461636138, 5736.741846616912, 5742.339630942495, 1401.9439222431192, 1482.48113160393, 1506.4727345429012, 1506.495324066428, 1512.0322993284308, 913.4975763330275, 957.2533423929347, 962.3119469579144, 973.5424350555228, 979.4661909259471, 4933.827316043993, 4951.777170027357, 4959.231319145538, 4962.60299176065, 4964.429090654548, 5829.504492118217, 5830.47525722687, 5836.766529338779, 5837.153612726131, 5840.649561026267, 4939.777710003059, 4948.752562371867, 4950.2079667253065, 4962.727050012284, 4963.801447942042, 3099.9225019374244, 3146.11908665574, 3146.678395074074, 3148.889788857379, 3153.542736303223, 5548.140038294071, 5554.0835762099605, 5556.111022236423, 5561.916571251353, 5562.3881373048935, 5917.230760001258, 6172.783952561728, 6173.536984726164, 6181.412765787243, 6183.721732521957, 5660.462256085665, 5689.9146512802345, 5691.573132015033, 5692.231548740867, 5698.886022279448, 5975.223220981245, 5978.461938425388, 5980.790672326448, 5983.34183239852, 5983.820485385445, 5866.823995280149, 5870.178175055581, 5871.500922421642, 5874.441928016831, 5875.383084776037, 5442.782288708408, 5671.631343962629, 5679.829605111853, 5688.317401911797, 5691.060974939089, 4000.8199631017255, 4002.0195052212393, 4022.879313620596, 4030.1939612077117, 4049.433079368832, 5905.911411328748, 5934.287885453773, 5935.376785437639, 5940.554458415722, 5941.851453713519, 5695.857603559944, 5733.512651424676, 5765.97117014429, 5767.826965191051, 5768.451997060272, 5713.085906254979, 5744.971275143597, 5748.223989761329, 5750.223719797774, 5767.8558036049435, 5421.078416669096, 5582.190582365615, 5647.983362994701, 5659.037963546125, 5662.546996240373, 5710.685912274865, 5780.0, 5784.566157538117, 5802.796902108406, 5810.4189581041555, 5646.3788983212635, 5655.406182350794, 5662.0, 5664.943350566442, 5672.404397538199], "unit": "score", "name": "prototype.html", "value": 4299.241612924272}, {"lowerIsBetter": false, "replicates": [644.1656710473915, 667.7362441835475, 671.5634837355719, 702.8769965256079, 766.6588368176164, 12530.937345313283, 12911.225326480419, 12925.159864608793, 12928.676783080416, 12929.224246545215, 12223.877761222386, 12272.07959403044, 12282.815757763641, 12284.078694097956, 12290.0, 644.4425571880313, 791.4894892794144, 796.044746304434, 816.5182542300042, 818.6397984886661, 811.7524155132683, 816.9550674712889, 819.778659761864, 819.9057108432518, 820.4666966471782, 860.3074525007366, 860.3977215948829, 860.711661593367, 861.8707193920899, 862.482510493705, 663.6880666086931, 831.0941074229089, 863.2101627011277, 863.3352318714586, 864.1703964194381, 621.934696856828, 622.8567429491197, 623.0498489803041, 623.2520974830222, 623.4357906094991, 12522.311272879988, 12629.0, 12664.493420263178, 12703.74592508154, 12740.235585864877, 11993.820092698617, 12421.1926224796, 12423.503059877594, 12444.937775311066, 12545.31000794956, 9731.659391921248, 9737.756556086084, 9797.118259356692, 9990.650327238585, 10009.84985225215, 3257.657945915692, 3311.4867195584725, 3386.915327116817, 3404.6254911959663, 3409.9318013639836, 42483.57516424827, 42817.57182428167, 43037.78481107575, 43097.13805723899, 43783.562164378585, 9774.902250977542, 9807.852882206773, 10244.53899574521, 10348.844767328495, 10367.377957322586, 17601.207945642476, 17612.91193544024, 17785.9328440294, 17820.821791782175, 17851.28594856217, 6814.352636499525, 6916.066331045345, 6941.965290173517, 7031.296870312928, 7148.499605027702, 3816.751911125768, 3886.0, 3923.843046278117, 3936.389859571771, 4048.21059893318, 2888.8988885388912, 2904.9273768155967, 2923.751481124128, 2924.532074868011, 2939.191722276348, 525.6241787122226, 559.7788873395068, 578.2713780636428, 581.1225050174268, 582.0570675505708, 544.5534661577548, 566.4562020460322, 576.3688760806909, 584.8537865533617, 588.5674029588249, 7141.9285807142305, 7480.962595186989, 7499.175090740015, 7638.390092879257, 8121.187881211949, 439.13271289204204, 475.4651017605194, 577.6158854361802, 579.2527639345282, 595.2291782142137, 3561.1809283864854, 3570.839312230956, 3642.1805093853673, 3687.539057617798, 3722.441633754904, 52723.20915186275, 53200.73399633054, 53250.733746331796, 53409.46590534045, 53537.46462535403, 45393.546064539594, 46430.76784616123, 46674.29988550174, 47220.0, 47448.762756186, 41919.161616767495, 42336.36495452571, 42932.14135717331, 42970.1405971885, 43246.56753432488, 7184.8922266165, 7294.323940103863, 7426.257374262531, 7429.7399591014055, 7448.9627551861895, 31730.682693172774, 32264.677353227107, 32702.182445438102, 32832.343353133285, 33003.339933201685, 36770.816145919096, 36973.26053478861, 38008.0, 41292.1741565173, 41407.585924140374, 9284.860727088964, 9436.575354108943, 9493.797319163177, 9957.302988790716, 9976.351537150062, 10541.736456588647, 10711.94644026806, 10739.624113156002, 10785.89214107849, 11265.26775759573, 10406.323588966692, 10530.84160742333, 10539.209559282932, 10777.083947864206, 10777.13782897382, 10469.213465251889, 10519.73700657459, 10586.364818110938, 10866.348019118877, 11167.218294719292, 10253.794924101625, 10280.126189273995, 10652.57389704403, 10730.839037414602, 10869.130469562258, 9033.277337812828, 9300.255979521757, 9386.389884657476, 9400.435973841591, 9453.527323633929, 8574.871376929475, 8780.9360206142, 9000.279977601907, 9111.253993650045, 9308.767280818034], "unit": "score", "name": "yui.html", "value": 5871.618683416927}], "name": "dromaeo_css", "value": 6475.50117001989}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 107.0, 111.0, 111.0, 112.0, 101.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [151.0, 129.0, 151.0, 176.0, 132.0, 153.0, 153.0, 131.0, 186.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 160.0, 160.0, 160.0, 163.0, 162.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 103.0, 94.0, 74.0, 73.0, 72.0, 109.0, 95.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 142.0, 92.0, 94.0, 93.0, 130.0, 94.0, 93.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 119.0, 118.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 71.0, 65.0, 65.0, 64.0, 65.0, 73.0, 64.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 65.9}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 83.0, 82.0, 81.0, 81.0, 82.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [115.0, 117.0, 124.0, 123.0, 127.0, 117.0, 124.0, 121.0, 129.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [138.0, 137.0, 140.0, 138.0, 147.0, 133.0, 139.0, 139.0, 140.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 68.0, 65.0, 66.0, 68.0, 68.0, 65.0, 64.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1509.1}]} 02:09:36 INFO - Return code: 0 02:09:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:09:36 ERROR - # TBPL SUCCESS # 02:09:36 INFO - Running post-action listener: _resource_record_post_action 02:09:36 INFO - Running post-run listener: _resource_record_post_run 02:09:37 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522797056; Read time: 16; Write time: 361932 02:09:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238546944; Read time: 0; Write time: 224264 02:09:37 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284250112; Read time: 16; Write time: 137668 02:09:37 INFO - Running post-run listener: _upload_blobber_files 02:09:37 INFO - Blob upload gear active. 02:09:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:09:37 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 02:09:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:09:38 INFO - (blobuploader) - INFO - Open directory for files ... 02:09:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:09:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:09:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:39 INFO - (blobuploader) - INFO - Done attempting. 02:09:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:09:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:09:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:40 INFO - (blobuploader) - INFO - Done attempting. 02:09:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:09:40 INFO - Return code: 0 02:09:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:09:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:09:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c22cd10530e80587faaf6601d57967ec0ebdaae6d4379159851e14c59a0041c7fe6c8255aed7fda016b08c3f3a54aedec7dad5e4455727dd5d4e77e78ef73075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/175074e3db769a07706a13a4dad96364a5ef8e9fc1f78ac4f0fcc39ae6ca0559fc5fe2b132cd52e1808e10175e7cb549f36f0461ab93b7d25847692ad51b3e27"} 02:09:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:09:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:09:40 INFO - Contents: 02:09:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c22cd10530e80587faaf6601d57967ec0ebdaae6d4379159851e14c59a0041c7fe6c8255aed7fda016b08c3f3a54aedec7dad5e4455727dd5d4e77e78ef73075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/175074e3db769a07706a13a4dad96364a5ef8e9fc1f78ac4f0fcc39ae6ca0559fc5fe2b132cd52e1808e10175e7cb549f36f0461ab93b7d25847692ad51b3e27"} 02:09:40 INFO - Running post-run listener: copy_logs_to_upload_dir 02:09:40 INFO - Copying logs to upload dir... 02:09:40 INFO - mkdir: /builds/slave/test/build/upload/logs 02:09:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.028909 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-18 02:09:39.725717) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 02:09:39.736336) ========= 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-1458290944.610111-1320820025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c22cd10530e80587faaf6601d57967ec0ebdaae6d4379159851e14c59a0041c7fe6c8255aed7fda016b08c3f3a54aedec7dad5e4455727dd5d4e77e78ef73075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/175074e3db769a07706a13a4dad96364a5ef8e9fc1f78ac4f0fcc39ae6ca0559fc5fe2b132cd52e1808e10175e7cb549f36f0461ab93b7d25847692ad51b3e27"} build_url:https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/R1rYHaZSTb-eouS3ltaY0w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c22cd10530e80587faaf6601d57967ec0ebdaae6d4379159851e14c59a0041c7fe6c8255aed7fda016b08c3f3a54aedec7dad5e4455727dd5d4e77e78ef73075", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/175074e3db769a07706a13a4dad96364a5ef8e9fc1f78ac4f0fcc39ae6ca0559fc5fe2b132cd52e1808e10175e7cb549f36f0461ab93b7d25847692ad51b3e27"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 02:09:39.764840) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 02:09:39.765182) ========= 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-1458290944.610111-1320820025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 02:09:39.814636) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 02:09:39.817997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 02:09:39.818409) ========= ========= Total master_lag: 0.23 =========