builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1457518469.78 results: success (0) buildid: 20160309012014 builduid: 356f0f7cabe4479b9fee3c755be1244e revision: 75dbc6dae2958ff0fd6001eb4a484afddc323a73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.779003) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.779566) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.779970) ========= 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=df17445c3590ff7897617a0e00000225-1457518469.260563-866938647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006260 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.803672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.804033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.818487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.818831) ========= 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=df17445c3590ff7897617a0e00000225-1457518469.260563-866938647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.868821) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.869191) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.869676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.870002) ========= 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=df17445c3590ff7897617a0e00000225-1457518469.260563-866938647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 02:14:30-- 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% 18.1M=0.001s 2016-03-09 02:14:30 (18.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095634 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.979739) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:29.980111) ========= 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=df17445c3590ff7897617a0e00000225-1457518469.260563-866938647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021950 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:30.030654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:30.031069) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 75dbc6dae2958ff0fd6001eb4a484afddc323a73 --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 75dbc6dae2958ff0fd6001eb4a484afddc323a73 --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=df17445c3590ff7897617a0e00000225-1457518469.260563-866938647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 02:14:30,244 truncating revision to first 12 chars 2016-03-09 02:14:30,244 Setting DEBUG logging. 2016-03-09 02:14:30,244 attempt 1/10 2016-03-09 02:14:30,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/75dbc6dae295?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 02:14:30,522 unpacking tar archive at: fx-team-75dbc6dae295/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596996 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:30.642001) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:30.642449) ========= echo 75dbc6dae2958ff0fd6001eb4a484afddc323a73 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'75dbc6dae2958ff0fd6001eb4a484afddc323a73'] 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=df17445c3590ff7897617a0e00000225-1457518469.260563-866938647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 75dbc6dae2958ff0fd6001eb4a484afddc323a73 program finished with exit code 0 elapsedTime=0.003934 script_repo_revision: '75dbc6dae2958ff0fd6001eb4a484afddc323a73' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:30.691760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:30.692148) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 02:14:30.702517) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-09 02:14:30.702866) ========= /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=df17445c3590ff7897617a0e00000225-1457518469.260563-866938647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:14:30 INFO - MultiFileLogger online at 20160309 02:14:30 in /builds/slave/test 02:14:30 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 02:14:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:14:31 INFO - {'append_to_log': False, 02:14:31 INFO - 'base_work_dir': '/builds/slave/test', 02:14:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:14:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:14:31 INFO - 'branch': 'Fx-Team-Non-PGO', 02:14:31 INFO - 'buildbot_json_path': 'buildprops.json', 02:14:31 INFO - 'config_files': ('talos/linux_config.py',), 02:14:31 INFO - 'default_actions': ('clobber', 02:14:31 INFO - 'read-buildbot-config', 02:14:31 INFO - 'download-and-extract', 02:14:31 INFO - 'populate-webroot', 02:14:31 INFO - 'create-virtualenv', 02:14:31 INFO - 'install', 02:14:31 INFO - 'run-tests'), 02:14:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:14:31 INFO - 'download_minidump_stackwalk': True, 02:14:31 INFO - 'download_symbols': 'ondemand', 02:14:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:14:31 INFO - 'tooltool.py': '/tools/tooltool.py', 02:14:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:14:31 INFO - '/tools/misc-python/virtualenv.py')}, 02:14:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:14:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:14:31 INFO - 'installer_path': 'installer.exe', 02:14:31 INFO - 'log_level': 'info', 02:14:31 INFO - 'log_name': 'talos', 02:14:31 INFO - 'log_to_console': True, 02:14:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:14:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:14:31 INFO - 'opt_config_files': (), 02:14:31 INFO - 'pip_index': False, 02:14:31 INFO - 'sps_profile': False, 02:14:31 INFO - 'sps_profile_interval': 0, 02:14:31 INFO - 'suite': 'dromaeojs', 02:14:31 INFO - 'system_bits': '32', 02:14:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:14:31 INFO - 'title': 'talos-linux64-ix-021', 02:14:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:14:31 INFO - 'use_talos_json': True, 02:14:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:14:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:14:31 INFO - 'work_dir': 'build'} 02:14:31 INFO - ##### 02:14:31 INFO - ##### Running clobber step. 02:14:31 INFO - ##### 02:14:31 INFO - Running pre-action listener: _resource_record_pre_action 02:14:31 INFO - Running main action method: clobber 02:14:31 INFO - rmtree: /builds/slave/test/build 02:14:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:14:31 INFO - Running post-action listener: _resource_record_post_action 02:14:31 INFO - ##### 02:14:31 INFO - ##### Running read-buildbot-config step. 02:14:31 INFO - ##### 02:14:31 INFO - Running pre-action listener: _resource_record_pre_action 02:14:31 INFO - Running main action method: read_buildbot_config 02:14:31 INFO - Using buildbot properties: 02:14:31 INFO - { 02:14:31 INFO - "project": "", 02:14:31 INFO - "product": "firefox", 02:14:31 INFO - "script_repo_revision": "production", 02:14:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:14:31 INFO - "repository": "", 02:14:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:14:31 INFO - "buildid": "20160309012014", 02:14:31 INFO - "pgo_build": "False", 02:14:31 INFO - "basedir": "/builds/slave/test", 02:14:31 INFO - "buildnumber": 1536, 02:14:31 INFO - "slavename": "talos-linux64-ix-021", 02:14:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:14:31 INFO - "platform": "ubuntu64_hw", 02:14:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:14:31 INFO - "branch": "fx-team", 02:14:31 INFO - "repo_path": "integration/fx-team", 02:14:31 INFO - "revision": "75dbc6dae2958ff0fd6001eb4a484afddc323a73", 02:14:31 INFO - "stage_platform": "linux64", 02:14:31 INFO - "builduid": "356f0f7cabe4479b9fee3c755be1244e", 02:14:31 INFO - "slavebuilddir": "test" 02:14:31 INFO - } 02:14:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:14:31 INFO - Running post-action listener: _resource_record_post_action 02:14:31 INFO - ##### 02:14:31 INFO - ##### Running download-and-extract step. 02:14:31 INFO - ##### 02:14:31 INFO - Running pre-action listener: _resource_record_pre_action 02:14:31 INFO - Running main action method: download_and_extract 02:14:31 INFO - mkdir: /builds/slave/test/build/tests 02:14:31 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')]} 02:14:31 INFO - https://queue.taskcluster.net/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:14:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:14:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:14:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/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 02:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/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 02:14:32 INFO - Downloaded 1361 bytes. 02:14:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:14:32 INFO - Using the following test package requirements: 02:14:32 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:14:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:14:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:14:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:32 INFO - u'jsshell-linux-x86_64.zip'], 02:14:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:14:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:14:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:14:32 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:14:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:14:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:14:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:14:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:32 INFO - https://queue.taskcluster.net/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/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 02:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/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 02:14:33 INFO - Downloaded 22092924 bytes. 02:14:33 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'] 02:14:33 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 02:14:34 INFO - Return code: 0 02:14:34 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 02:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:34 INFO - https://queue.taskcluster.net/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/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 02:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/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 02:14:35 INFO - Downloaded 22092924 bytes. 02:14:35 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'] 02:14:35 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 02:14:37 INFO - Return code: 0 02:14: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')]} 02:14:37 INFO - https://queue.taskcluster.net/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/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 02:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/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 02:14:38 INFO - Downloaded 10845161 bytes. 02:14:38 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'] 02:14:38 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 02:14:38 INFO - Return code: 0 02:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:38 INFO - https://queue.taskcluster.net/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/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 02:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cpUpMppJRGazTOqfEnO9Tg/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 02:14:39 INFO - Downloaded 54321411 bytes. 02:14:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:14:39 INFO - mkdir: /builds/slave/test/properties 02:14:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:14:39 INFO - Writing to file /builds/slave/test/properties/build_url 02:14:39 INFO - Contents: 02:14:39 INFO - build_url:https://queue.taskcluster.net/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:14:40 INFO - Running post-action listener: _resource_record_post_action 02:14:40 INFO - Running post-action listener: set_extra_try_arguments 02:14:40 INFO - ##### 02:14:40 INFO - ##### Running populate-webroot step. 02:14:40 INFO - ##### 02:14:40 INFO - Running pre-action listener: _resource_record_pre_action 02:14:40 INFO - Running main action method: populate_webroot 02:14:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:14:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:14:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:14:40 INFO - '--tppagecycles', 02:14:40 INFO - '7'], 02:14:40 INFO - 'tests': ['tsvgm']}}, 02:14:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:14:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:14:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:14:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:14:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:14:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:14:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:40 INFO - 'talos_options': ['--e10s'], 02:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:40 INFO - 'tests': ['damp', 'tps']}, 02:14:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:40 INFO - 'talos_options': ['--e10s'], 02:14:40 INFO - 'tests': ['damp', 'tps']}, 02:14:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:14:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:14:40 INFO - 'other': {'tests': ['a11yr', 02:14:40 INFO - 'ts_paint', 02:14:40 INFO - 'tpaint', 02:14:40 INFO - 'sessionrestore', 02:14:40 INFO - 'sessionrestore_no_auto_restore', 02:14:40 INFO - 'tabpaint']}, 02:14:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:14:40 INFO - 'tests': ['a11yr', 02:14:40 INFO - 'ts_paint', 02:14:40 INFO - 'tpaint', 02:14:40 INFO - 'sessionrestore', 02:14:40 INFO - 'sessionrestore_no_auto_restore', 02:14:40 INFO - 'tabpaint']}, 02:14:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:14:40 INFO - 'tests': ['a11yr', 02:14:40 INFO - 'ts_paint', 02:14:40 INFO - 'tpaint', 02:14:40 INFO - 'sessionrestore', 02:14:40 INFO - 'sessionrestore_no_auto_restore', 02:14:40 INFO - 'tabpaint']}, 02:14:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:14:40 INFO - 'tests': ['a11yr', 02:14:40 INFO - 'ts_paint', 02:14:40 INFO - 'tpaint', 02:14:40 INFO - 'sessionrestore', 02:14:40 INFO - 'sessionrestore_no_auto_restore', 02:14:40 INFO - 'tabpaint']}, 02:14:40 INFO - 'other_l64': {'tests': ['a11yr', 02:14:40 INFO - 'ts_paint', 02:14:40 INFO - 'tpaint', 02:14:40 INFO - 'sessionrestore', 02:14:40 INFO - 'sessionrestore_no_auto_restore', 02:14:40 INFO - 'tabpaint']}, 02:14:40 INFO - 'other_nol64': {'tests': ['a11yr', 02:14:40 INFO - 'ts_paint', 02:14:40 INFO - 'tpaint', 02:14:40 INFO - 'sessionrestore', 02:14:40 INFO - 'sessionrestore_no_auto_restore', 02:14:40 INFO - 'tabpaint']}, 02:14:40 INFO - 'svgr': {'tests': ['tsvgx', 02:14:40 INFO - 'tsvgr_opacity', 02:14:40 INFO - 'tart', 02:14:40 INFO - 'tscrollx', 02:14:40 INFO - 'cart']}, 02:14:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:14:40 INFO - 'tests': ['tsvgx', 02:14:40 INFO - 'tsvgr_opacity', 02:14:40 INFO - 'tart', 02:14:40 INFO - 'tscrollx', 02:14:40 INFO - 'cart']}, 02:14:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:40 INFO - 'tests': ['tp5o']}, 02:14:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:40 INFO - 'talos_options': ['--e10s'], 02:14:40 INFO - 'tests': ['tp5o']}, 02:14:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:40 INFO - 'talos_options': ['--xperf_path', 02:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:40 INFO - 'tests': ['tp5n']}, 02:14:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:40 INFO - 'talos_options': ['--e10s', 02:14:40 INFO - '--xperf_path', 02:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:40 INFO - 'tests': ['tp5n']}}, 02:14:40 INFO - 'talos.zip': {'path': '', 02:14:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:14:40 INFO - Running post-action listener: _resource_record_post_action 02:14:40 INFO - ##### 02:14:40 INFO - ##### Running create-virtualenv step. 02:14:40 INFO - ##### 02:14:40 INFO - Running pre-action listener: _resource_record_pre_action 02:14:40 INFO - Running main action method: create_virtualenv 02:14:40 INFO - Creating virtualenv /builds/slave/test/build/venv 02:14:40 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 02:14:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:14:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:14:40 INFO - Using real prefix '/usr' 02:14:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:14:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:14:43 INFO - Installing pip.................done. 02:14:43 INFO - Return code: 0 02:14:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:43 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 0x7ffeef2c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be160>, '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 0x13bf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf4f0>, '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': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', '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 02:14:43 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 02:14:43 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 02:14:43 INFO - Using env: {'DISPLAY': ':0', 02:14:43 INFO - 'HOME': '/home/cltbld', 02:14:43 INFO - 'LANG': 'en_US.UTF-8', 02:14:43 INFO - 'LANGUAGE': 'en_US:en', 02:14:43 INFO - 'LOGNAME': 'cltbld', 02:14:43 INFO - 'MAIL': '/var/mail/cltbld', 02:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:43 INFO - 'MOZ_NO_REMOTE': '1', 02:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:43 INFO - 'NO_EM_RESTART': '1', 02:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:43 INFO - 'PWD': '/builds/slave/test', 02:14:43 INFO - 'SHELL': '/bin/bash', 02:14:43 INFO - 'SHLVL': '1', 02:14:43 INFO - 'TERM': 'linux', 02:14:43 INFO - 'TMOUT': '86400', 02:14:43 INFO - 'USER': 'cltbld', 02:14:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', 02:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:43 INFO - '_': '/tools/buildbot/bin/python'} 02:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:43 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 02:14:43 INFO - Cleaning up... 02:14:43 INFO - Return code: 0 02:14:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:43 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 0x7ffeef2c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be160>, '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 0x13bf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf4f0>, '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': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', '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 02:14:43 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 02:14:43 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 02:14:43 INFO - Using env: {'DISPLAY': ':0', 02:14:43 INFO - 'HOME': '/home/cltbld', 02:14:43 INFO - 'LANG': 'en_US.UTF-8', 02:14:43 INFO - 'LANGUAGE': 'en_US:en', 02:14:43 INFO - 'LOGNAME': 'cltbld', 02:14:43 INFO - 'MAIL': '/var/mail/cltbld', 02:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:43 INFO - 'MOZ_NO_REMOTE': '1', 02:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:43 INFO - 'NO_EM_RESTART': '1', 02:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:43 INFO - 'PWD': '/builds/slave/test', 02:14:43 INFO - 'SHELL': '/bin/bash', 02:14:43 INFO - 'SHLVL': '1', 02:14:43 INFO - 'TERM': 'linux', 02:14:43 INFO - 'TMOUT': '86400', 02:14:43 INFO - 'USER': 'cltbld', 02:14:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', 02:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:43 INFO - '_': '/tools/buildbot/bin/python'} 02:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:43 INFO - Downloading/unpacking psutil>=0.7.1 02:14:43 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 02:14:43 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 02:14:43 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 02:14:43 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 02:14:43 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 02:14:43 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 02:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:45 INFO - Installing collected packages: psutil 02:14:45 INFO - Running setup.py install for psutil 02:14:45 INFO - building 'psutil._psutil_linux' extension 02:14:45 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 02:14:45 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 02:14:45 INFO - building 'psutil._psutil_posix' extension 02:14:45 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 02:14:45 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 02:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:45 INFO - Successfully installed psutil 02:14:45 INFO - Cleaning up... 02:14:45 INFO - Return code: 0 02:14:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:45 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 0x7ffeef2c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be160>, '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 0x13bf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf4f0>, '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': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', '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 02:14:45 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 02:14:45 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 02:14:45 INFO - Using env: {'DISPLAY': ':0', 02:14:45 INFO - 'HOME': '/home/cltbld', 02:14:45 INFO - 'LANG': 'en_US.UTF-8', 02:14:45 INFO - 'LANGUAGE': 'en_US:en', 02:14:45 INFO - 'LOGNAME': 'cltbld', 02:14:45 INFO - 'MAIL': '/var/mail/cltbld', 02:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:45 INFO - 'MOZ_NO_REMOTE': '1', 02:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:45 INFO - 'NO_EM_RESTART': '1', 02:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:45 INFO - 'PWD': '/builds/slave/test', 02:14:45 INFO - 'SHELL': '/bin/bash', 02:14:45 INFO - 'SHLVL': '1', 02:14:45 INFO - 'TERM': 'linux', 02:14:45 INFO - 'TMOUT': '86400', 02:14:45 INFO - 'USER': 'cltbld', 02:14:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', 02:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:45 INFO - '_': '/tools/buildbot/bin/python'} 02:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:14:46 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 02:14:46 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 02:14:46 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 02:14:46 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 02:14:46 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 02:14:46 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 02:14:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:14:48 INFO - Installing collected packages: mozsystemmonitor 02:14:48 INFO - Running setup.py install for mozsystemmonitor 02:14:48 INFO - Successfully installed mozsystemmonitor 02:14:48 INFO - Cleaning up... 02:14:48 INFO - Return code: 0 02:14:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:48 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 0x7ffeef2c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be160>, '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 0x13bf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf4f0>, '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': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', '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 02:14:48 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 02:14:48 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 02:14:48 INFO - Using env: {'DISPLAY': ':0', 02:14:48 INFO - 'HOME': '/home/cltbld', 02:14:48 INFO - 'LANG': 'en_US.UTF-8', 02:14:48 INFO - 'LANGUAGE': 'en_US:en', 02:14:48 INFO - 'LOGNAME': 'cltbld', 02:14:48 INFO - 'MAIL': '/var/mail/cltbld', 02:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:48 INFO - 'MOZ_NO_REMOTE': '1', 02:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:48 INFO - 'NO_EM_RESTART': '1', 02:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:48 INFO - 'PWD': '/builds/slave/test', 02:14:48 INFO - 'SHELL': '/bin/bash', 02:14:48 INFO - 'SHLVL': '1', 02:14:48 INFO - 'TERM': 'linux', 02:14:48 INFO - 'TMOUT': '86400', 02:14:48 INFO - 'USER': 'cltbld', 02:14:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', 02:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:48 INFO - '_': '/tools/buildbot/bin/python'} 02:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:14:48 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 02:14:48 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 02:14:48 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 02:14:48 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 02:14:48 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 02:14:48 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 02:14:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:14:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:14:50 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 02:14:50 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 02:14:50 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 02:14:50 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 02:14:50 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 02:14:50 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 02:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:14:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:14:50 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 02:14:50 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 02:14:50 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 02:14:50 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 02:14:50 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 02:14:50 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 02:14:50 INFO - Downloading docopt-0.6.1.tar.gz 02:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:14:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:14:51 INFO - Running setup.py install for blobuploader 02:14:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:14:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:14:51 INFO - Running setup.py install for requests 02:14:51 INFO - Running setup.py install for docopt 02:14:51 INFO - Successfully installed blobuploader requests docopt 02:14:51 INFO - Cleaning up... 02:14:51 INFO - Return code: 0 02:14:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:51 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 0x7ffeef2c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be160>, '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 0x13bf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf4f0>, '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': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', '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 02:14:51 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 02:14:51 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 02:14:51 INFO - Using env: {'DISPLAY': ':0', 02:14:51 INFO - 'HOME': '/home/cltbld', 02:14:51 INFO - 'LANG': 'en_US.UTF-8', 02:14:51 INFO - 'LANGUAGE': 'en_US:en', 02:14:51 INFO - 'LOGNAME': 'cltbld', 02:14:51 INFO - 'MAIL': '/var/mail/cltbld', 02:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:51 INFO - 'MOZ_NO_REMOTE': '1', 02:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:51 INFO - 'NO_EM_RESTART': '1', 02:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:51 INFO - 'PWD': '/builds/slave/test', 02:14:51 INFO - 'SHELL': '/bin/bash', 02:14:51 INFO - 'SHLVL': '1', 02:14:51 INFO - 'TERM': 'linux', 02:14:51 INFO - 'TMOUT': '86400', 02:14:51 INFO - 'USER': 'cltbld', 02:14:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', 02:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:51 INFO - '_': '/tools/buildbot/bin/python'} 02:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:51 INFO - Running setup.py (path:/tmp/pip-4YhwsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:51 INFO - Running setup.py (path:/tmp/pip-A6uuaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:52 INFO - Running setup.py (path:/tmp/pip-QO3pgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:52 INFO - Running setup.py (path:/tmp/pip-m6g8CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:52 INFO - Running setup.py (path:/tmp/pip-gUnAfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:52 INFO - Running setup.py (path:/tmp/pip-FbVPPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:52 INFO - Running setup.py (path:/tmp/pip-GGpUxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:52 INFO - Running setup.py (path:/tmp/pip-ntNgHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:52 INFO - Running setup.py (path:/tmp/pip-BWFaud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:52 INFO - Running setup.py (path:/tmp/pip-uQVQW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:52 INFO - Running setup.py (path:/tmp/pip-sW12jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:52 INFO - Running setup.py (path:/tmp/pip-9B8dMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:52 INFO - Running setup.py (path:/tmp/pip-_zFvhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:52 INFO - Running setup.py (path:/tmp/pip-jxSJ8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:52 INFO - Running setup.py (path:/tmp/pip-oZdS6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:52 INFO - Running setup.py (path:/tmp/pip-xI6aXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:53 INFO - Running setup.py (path:/tmp/pip-nmyhGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:14:53 INFO - Running setup.py install for manifestparser 02:14:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:14:53 INFO - Running setup.py install for mozcrash 02:14:53 INFO - Running setup.py install for mozdebug 02:14:53 INFO - Running setup.py install for mozdevice 02:14:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:14:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:14:53 INFO - Running setup.py install for mozfile 02:14:53 INFO - Running setup.py install for mozhttpd 02:14:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:14:53 INFO - Running setup.py install for mozinfo 02:14:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:14:53 INFO - Running setup.py install for mozInstall 02:14:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:14:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:14:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:14:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:14:53 INFO - Running setup.py install for mozleak 02:14:54 INFO - Running setup.py install for mozlog 02:14:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:14:54 INFO - Running setup.py install for moznetwork 02:14:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:14:54 INFO - Running setup.py install for mozprocess 02:14:54 INFO - Running setup.py install for mozprofile 02:14:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:14:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:14:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:14:54 INFO - Running setup.py install for mozrunner 02:14:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:14:54 INFO - Running setup.py install for mozscreenshot 02:14:54 INFO - Running setup.py install for moztest 02:14:54 INFO - Running setup.py install for mozversion 02:14:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:14:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:14:54 INFO - Cleaning up... 02:14:54 INFO - Return code: 0 02:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:54 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 0x7ffeef2c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be160>, '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 0x13bf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf4f0>, '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': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', '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 02:14:54 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 02:14:54 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 02:14:54 INFO - Using env: {'DISPLAY': ':0', 02:14:54 INFO - 'HOME': '/home/cltbld', 02:14:54 INFO - 'LANG': 'en_US.UTF-8', 02:14:54 INFO - 'LANGUAGE': 'en_US:en', 02:14:54 INFO - 'LOGNAME': 'cltbld', 02:14:54 INFO - 'MAIL': '/var/mail/cltbld', 02:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:54 INFO - 'MOZ_NO_REMOTE': '1', 02:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:54 INFO - 'NO_EM_RESTART': '1', 02:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:54 INFO - 'PWD': '/builds/slave/test', 02:14:54 INFO - 'SHELL': '/bin/bash', 02:14:54 INFO - 'SHLVL': '1', 02:14:54 INFO - 'TERM': 'linux', 02:14:54 INFO - 'TMOUT': '86400', 02:14:54 INFO - 'USER': 'cltbld', 02:14:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', 02:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:54 INFO - '_': '/tools/buildbot/bin/python'} 02:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:55 INFO - Running setup.py (path:/tmp/pip-s0X51E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:55 INFO - Running setup.py (path:/tmp/pip-4s0qYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:55 INFO - Running setup.py (path:/tmp/pip-8M8v1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:55 INFO - Running setup.py (path:/tmp/pip-xxPm2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:55 INFO - Running setup.py (path:/tmp/pip-YvzpSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:55 INFO - Running setup.py (path:/tmp/pip-yxr6gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:55 INFO - Running setup.py (path:/tmp/pip-Yi5o4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:55 INFO - Running setup.py (path:/tmp/pip-fLzByW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:55 INFO - Running setup.py (path:/tmp/pip-fbHoDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:55 INFO - Running setup.py (path:/tmp/pip-0t42z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:55 INFO - Running setup.py (path:/tmp/pip-y4Zeto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:55 INFO - Running setup.py (path:/tmp/pip-oVAJRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:55 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)) 02:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:55 INFO - Running setup.py (path:/tmp/pip-7yqDTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:56 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)) 02:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:56 INFO - Running setup.py (path:/tmp/pip-dSO1pF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:56 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)) 02:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:56 INFO - Running setup.py (path:/tmp/pip-oZUr3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:56 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)) 02:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:56 INFO - Running setup.py (path:/tmp/pip-VzViUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:56 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)) 02:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:56 INFO - Running setup.py (path:/tmp/pip-Blxf2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:56 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)) 02:14:56 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)) 02:14:56 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)) 02:14:56 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)) 02:14:56 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)) 02:14:56 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)) 02:14:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:14:56 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 02:14:56 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 02:14:56 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 02:14:56 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 02:14:56 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 02:14:56 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 02:14:58 INFO - Downloading blessings-1.6.tar.gz 02:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:14:58 INFO - Installing collected packages: blessings 02:14:58 INFO - Running setup.py install for blessings 02:14:58 INFO - Successfully installed blessings 02:14:58 INFO - Cleaning up... 02:14:58 INFO - Return code: 0 02:14:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:14:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:58 INFO - Reading from file tmpfile_stdout 02:14:58 INFO - Current package versions: 02:14:58 INFO - argparse == 1.2.1 02:14:58 INFO - blessings == 1.6 02:14:58 INFO - blobuploader == 1.2.4 02:14:58 INFO - docopt == 0.6.1 02:14:58 INFO - manifestparser == 1.1 02:14:58 INFO - mozInstall == 1.12 02:14:58 INFO - mozcrash == 0.17 02:14:58 INFO - mozdebug == 0.1 02:14:58 INFO - mozdevice == 0.48 02:14:58 INFO - mozfile == 1.2 02:14:58 INFO - mozhttpd == 0.7 02:14:58 INFO - mozinfo == 0.9 02:14:58 INFO - mozleak == 0.1 02:14:58 INFO - mozlog == 3.1 02:14:58 INFO - moznetwork == 0.27 02:14:58 INFO - mozprocess == 0.22 02:14:58 INFO - mozprofile == 0.28 02:14:58 INFO - mozrunner == 6.11 02:14:58 INFO - mozscreenshot == 0.1 02:14:58 INFO - mozsystemmonitor == 0.0 02:14:58 INFO - moztest == 0.7 02:14:58 INFO - mozversion == 1.4 02:14:58 INFO - psutil == 3.1.1 02:14:58 INFO - requests == 1.2.3 02:14:58 INFO - wsgiref == 0.1.2 02:14:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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')]} 02:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:58 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 0x7ffeef2c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be160>, '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 0x13bf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf4f0>, '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': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', '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 02:14:58 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 02:14:58 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 02:14:58 INFO - Using env: {'DISPLAY': ':0', 02:14:58 INFO - 'HOME': '/home/cltbld', 02:14:58 INFO - 'LANG': 'en_US.UTF-8', 02:14:58 INFO - 'LANGUAGE': 'en_US:en', 02:14:58 INFO - 'LOGNAME': 'cltbld', 02:14:58 INFO - 'MAIL': '/var/mail/cltbld', 02:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:58 INFO - 'MOZ_NO_REMOTE': '1', 02:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:58 INFO - 'NO_EM_RESTART': '1', 02:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:58 INFO - 'PWD': '/builds/slave/test', 02:14:58 INFO - 'SHELL': '/bin/bash', 02:14:58 INFO - 'SHLVL': '1', 02:14:58 INFO - 'TERM': 'linux', 02:14:58 INFO - 'TMOUT': '86400', 02:14:58 INFO - 'USER': 'cltbld', 02:14:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', 02:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:58 INFO - '_': '/tools/buildbot/bin/python'} 02:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:58 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)) 02:14:58 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)) 02:14:58 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)) 02:14:58 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)) 02:14:58 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)) 02:14:58 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)) 02:14:58 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)) 02:14:58 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)) 02:14:58 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)) 02:14:58 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)) 02:14:58 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)) 02:14:58 INFO - Cleaning up... 02:14:58 INFO - Return code: 0 02:14:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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')]} 02:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeef2c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be160>, '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 0x13bf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf4f0>, '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': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', '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 02:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:14:58 INFO - Using env: {'DISPLAY': ':0', 02:14:58 INFO - 'HOME': '/home/cltbld', 02:14:58 INFO - 'LANG': 'en_US.UTF-8', 02:14:58 INFO - 'LANGUAGE': 'en_US:en', 02:14:58 INFO - 'LOGNAME': 'cltbld', 02:14:58 INFO - 'MAIL': '/var/mail/cltbld', 02:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:58 INFO - 'MOZ_NO_REMOTE': '1', 02:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:58 INFO - 'NO_EM_RESTART': '1', 02:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:58 INFO - 'PWD': '/builds/slave/test', 02:14:58 INFO - 'SHELL': '/bin/bash', 02:14:58 INFO - 'SHLVL': '1', 02:14:58 INFO - 'TERM': 'linux', 02:14:58 INFO - 'TMOUT': '86400', 02:14:58 INFO - 'USER': 'cltbld', 02:14:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', 02:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:58 INFO - '_': '/tools/buildbot/bin/python'} 02:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:59 INFO - Downloading/unpacking jsonschema 02:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:15:00 INFO - Downloading/unpacking functools32 (from jsonschema) 02:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:01 INFO - Downloading functools32-3.2.3-2.tar.gz 02:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:15:01 INFO - warning: no files found matching '*.txt' 02:15:01 INFO - no previously-included directories found matching 'build' 02:15:01 INFO - no previously-included directories found matching 'dist' 02:15:01 INFO - no previously-included directories found matching '.git*' 02:15:01 INFO - Installing collected packages: jsonschema, functools32 02:15:01 INFO - Running setup.py install for functools32 02:15:01 INFO - warning: no files found matching '*.txt' 02:15:01 INFO - no previously-included directories found matching 'build' 02:15:01 INFO - no previously-included directories found matching 'dist' 02:15:01 INFO - no previously-included directories found matching '.git*' 02:15:01 INFO - Successfully installed jsonschema functools32 02:15:01 INFO - Cleaning up... 02:15:01 INFO - Return code: 0 02:15:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeef2c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be160>, '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 0x13bf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf4f0>, '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': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', '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 02:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:15:01 INFO - Using env: {'DISPLAY': ':0', 02:15:01 INFO - 'HOME': '/home/cltbld', 02:15:01 INFO - 'LANG': 'en_US.UTF-8', 02:15:01 INFO - 'LANGUAGE': 'en_US:en', 02:15:01 INFO - 'LOGNAME': 'cltbld', 02:15:01 INFO - 'MAIL': '/var/mail/cltbld', 02:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:01 INFO - 'MOZ_NO_REMOTE': '1', 02:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:01 INFO - 'NO_EM_RESTART': '1', 02:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:01 INFO - 'PWD': '/builds/slave/test', 02:15:01 INFO - 'SHELL': '/bin/bash', 02:15:01 INFO - 'SHLVL': '1', 02:15:01 INFO - 'TERM': 'linux', 02:15:01 INFO - 'TMOUT': '86400', 02:15:01 INFO - 'USER': 'cltbld', 02:15:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', 02:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:01 INFO - '_': '/tools/buildbot/bin/python'} 02:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:01 INFO - Downloading/unpacking flake8 02:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:15:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:15:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:15:04 INFO - no previously-included directories found matching 'docs/_build' 02:15:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:15:04 INFO - Running setup.py install for pep8 02:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:15:04 INFO - no previously-included directories found matching 'docs/_build' 02:15:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:15:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:15:04 INFO - Cleaning up... 02:15:04 INFO - Return code: 0 02:15:04 INFO - Running post-action listener: _resource_record_post_action 02:15:04 INFO - Running post-action listener: _start_resource_monitoring 02:15:04 INFO - Starting resource monitoring. 02:15:04 INFO - ##### 02:15:04 INFO - ##### Running install step. 02:15:04 INFO - ##### 02:15:04 INFO - Running pre-action listener: _resource_record_pre_action 02:15:04 INFO - Running main action method: install 02:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:15:04 INFO - Reading from file tmpfile_stdout 02:15:04 INFO - Detecting whether we're running mozinstall >=1.0... 02:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:15:04 INFO - Reading from file tmpfile_stdout 02:15:04 INFO - Output received: 02:15:04 INFO - Usage: mozinstall [options] installer 02:15:04 INFO - Options: 02:15:04 INFO - -h, --help show this help message and exit 02:15:04 INFO - -d DEST, --destination=DEST 02:15:04 INFO - Directory to install application into. [default: 02:15:04 INFO - "/builds/slave/test"] 02:15:04 INFO - --app=APP Application being installed. [default: firefox] 02:15:04 INFO - mkdir: /builds/slave/test/build/application 02:15:04 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'] 02:15:04 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 02:15:21 INFO - Reading from file tmpfile_stdout 02:15:21 INFO - Output received: 02:15:21 INFO - /builds/slave/test/build/application/firefox/firefox 02:15:21 INFO - Running post-action listener: _resource_record_post_action 02:15:21 INFO - ##### 02:15:21 INFO - ##### Running run-tests step. 02:15:21 INFO - ##### 02:15:21 INFO - Running pre-action listener: _resource_record_pre_action 02:15:21 INFO - Running main action method: run_tests 02:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:15:21 INFO - Python 2.7.3 02:15:21 INFO - Return code: 0 02:15:21 INFO - grabbing minidump binary from tooltool 02:15: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')]} 02:15:21 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 0x13be160>, '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 0x13bf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bf4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:15:21 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 02:15:21 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 02:15:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:15:21 INFO - Return code: 0 02:15:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:15:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:15:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:15:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:15:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:15:22 INFO - Return code: 0 02:15:22 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/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 02:15:22 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/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 02:15:22 INFO - Using env: {'DISPLAY': ':0', 02:15:22 INFO - 'HOME': '/home/cltbld', 02:15:22 INFO - 'LANG': 'en_US.UTF-8', 02:15:22 INFO - 'LANGUAGE': 'en_US:en', 02:15:22 INFO - 'LOGNAME': 'cltbld', 02:15:22 INFO - 'MAIL': '/var/mail/cltbld', 02:15:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:15:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:22 INFO - 'MOZ_NO_REMOTE': '1', 02:15:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:22 INFO - 'NO_EM_RESTART': '1', 02:15:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:22 INFO - 'PWD': '/builds/slave/test', 02:15:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:15:22 INFO - 'SHELL': '/bin/bash', 02:15:22 INFO - 'SHLVL': '1', 02:15:22 INFO - 'TERM': 'linux', 02:15:22 INFO - 'TMOUT': '86400', 02:15:22 INFO - 'USER': 'cltbld', 02:15:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1457518469.260563-866938647', 02:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:22 INFO - '_': '/tools/buildbot/bin/python'} 02:15:22 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/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 02:15:23 INFO - mozversion application_buildid: 20160309012014 02:15:23 INFO - mozversion application_changeset: 75dbc6dae2958ff0fd6001eb4a484afddc323a73 02:15:23 INFO - mozversion application_display_name: Nightly 02:15:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:15:23 INFO - mozversion application_name: Firefox 02:15:23 INFO - mozversion application_remotingname: firefox 02:15:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:15:23 INFO - mozversion application_vendor: Mozilla 02:15:23 INFO - mozversion application_version: 48.0a1 02:15:23 INFO - mozversion platform_buildid: 20160309012014 02:15:23 INFO - mozversion platform_changeset: 75dbc6dae2958ff0fd6001eb4a484afddc323a73 02:15:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:15:23 INFO - mozversion platform_version: 48.0a1 02:15:23 INFO - using testdate: 1457518523 02:15:23 INFO - actual date: 1457518523 02:15:23 INFO - starting webserver on 'localhost:39671' 02:15:23 INFO - SUITE-START | Running 2 tests 02:15:23 INFO - TEST-START | dromaeo_css 02:15:23 INFO - operating with platform_type : linux_ 02:15:23 INFO - Initialising browser for dromaeo_css test... 02:15:23 INFO - TEST-INFO | started process 5760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpilei7N/profile http://localhost:39671/getInfo.html) 02:15:28 INFO - PROCESS | 5760 | __metrics Screen width/height:1600/1200 02:15:28 INFO - PROCESS | 5760 | colorDepth:24 02:15:28 INFO - PROCESS | 5760 | Browser inner width/height: 1024/697 02:15:28 INFO - PROCESS | 5760 | __metrics 02:15:30 ERROR - PROCESS | 5760 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:15:30 INFO - PROCESS | 5760 | 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. 02:15:31 INFO - TEST-INFO | 5760: exit 0 02:15:31 INFO - Browser initialized. 02:15:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:15:31 INFO - TEST-INFO | started process 5853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpilei7N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:43 INFO - PROCESS | 5853 | RSS: Main: 154099712 02:15:43 INFO - PROCESS | 5853 | 02:16:34 INFO - PROCESS | 5853 | 1457518594561 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] 02:18:46 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39671/tests/dromaeo/cssquery-ext.html) 02:18:47 INFO - PROCESS | 5853 | RSS: Main: 245764096 02:18:47 INFO - PROCESS | 5853 | 02:21:49 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-ext.html (next: http://localhost:39671/tests/dromaeo/cssquery-jquery.html) 02:21:50 INFO - PROCESS | 5853 | RSS: Main: 240340992 02:21:50 INFO - PROCESS | 5853 | 02:24:52 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39671/tests/dromaeo/cssquery-mootools.html) 02:24:52 INFO - PROCESS | 5853 | RSS: Main: 238841856 02:24:52 INFO - PROCESS | 5853 | 02:27:54 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39671/tests/dromaeo/cssquery-prototype.html) 02:27:55 INFO - PROCESS | 5853 | RSS: Main: 219836416 02:27:55 INFO - PROCESS | 5853 | 02:30:58 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39671/tests/dromaeo/cssquery-yui.html) 02:30:58 INFO - PROCESS | 5853 | RSS: Main: 225841152 02:30:58 INFO - PROCESS | 5853 | 02:34:01 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-yui.html (next: http://localhost:39671/tests/dromaeo/cssquery-dojo.html) 02:34:01 INFO - PROCESS | 5853 | RSS: Main: 266854400 02:34:01 INFO - PROCESS | 5853 | 02:34:01 INFO - PROCESS | 5853 | __start_tp_report 02:34:01 INFO - PROCESS | 5853 | _x_x_mozilla_page_load 02:34:01 INFO - PROCESS | 5853 | _x_x_mozilla_page_load_details 02:34:01 INFO - PROCESS | 5853 | |i|pagename|runs| 02:34:01 INFO - PROCESS | 5853 | |0;dojo.html;2576.5362234797735;2626;2658.202539238228;2664.3871909460836;2691.7442842929922;4500.459944806627;4621.6533759968015;4630.6527010474265;4634.675572709907;4638.350630911675;4554.2713165893465;4589.770511474429;4599.241125214336;4599.40207772989;4664.2770370592525;4178.039051018268;4234.576542345764;4292.441982542266;4360.847370342039;4392.12157568486;4121.1757648470275;4290.292101803198;4340;4343.04453020335;4358.934615980763;4190.0572371216385;4261.31818908973;4268.893277668083;4311.116221174651;4315.633171180453;4261.339492378686;4272.893177670552;4276.102018576103;4288.656907447428;4309.267424537836;4171.91656166878;4230.2174097792;4247.320428731388;4253.510846252659;4293.248681480728;4493.348464472666;4597.977010114928;4614.446266448048;4621.3299071634765;4666.6500012498855;4908.239222920453;4912.582430493412;4913.631477639191;4913.828016019422;4918.385201849769;4832.492588278251;4928.310036594879;4938.80244790208;5000.599952003831;5035.697858128524;4580.198465268565;4587.220172570671;4589.954100458986;4590.127875703605;4618.261078227468;5069.138246498104;5074.112030394666;5075.5178258065425;5081.958198569285;5090.796368145307;4728.881777955578;4777.71333719971;4847.515248475195;4867.3915760529935;4897.706137631753;4894.486078961729;4905.730184839868;4912.04215178044;4914.631402644816;4960.578350840146;4874;4878.585320247747;4879.609631229493;4881.121398148367;4927;4706.599939005155;4784.856454306377;4874.2444921037295;4918.877028074256;4928.950710492849;4114;4119.114390406077;4120.196561670446;4143.274926887782;4161.479815023122;3544.326577950181;3614.530111085595;3621.511096002006;3641.8361173747244;3651.908702282464;4205.684573656988;4215.283401821697;4270.701050926467;4302.182585308781;4307.030918043415;4832.202686556749;4855.854324370274;4859.222524396079;4861.683990540603;4908.730019848871;4189.05746207107;4195.244855925963;4201.222773786859;4213.115245798355;4239.364095385655;4351.4995775485595;4404.493483249467;4409.9559004410185;4426.3581780641625;4455.6658250631335;4726.338312636233;4740.454847692559;4740.6444516660695;4744.4543877454535;4763.2140696784645;4760.238361862085;4909.68087074339;4971.850844474671;4974.104661160881;5006.524380183877;4731.219348807408;4749.786259618395;4751.192297309397;4752.097101550694;4801.231802911518;4860.975695121501;4883.80464781419;4887.34020907173;4889;4924.285978533164;4844.467108617979;4901.730404827768;4903.239997800347;4990.101781679333;4992.775325110306;4814;4830.806767729251;4841.273808928689;4841.298011788201;4884.072026314989;4770.308305295644;4773.427188737373;4777.737224452689;4790;4826.372571565815;4515;4608.216603177535;4657.417822772153;4714.764261786965;4718.693284936468;4828.058528586892;4828.5412885775795;4839.080574690797;4846.103470857903;4883.658143929891;4734.668573199843;4735.928961065518;4737.455192652889;4746.43042834862;4763.285507173813 02:34:01 INFO - PROCESS | 5853 | |1;ext.html;498.4865588443902;513.8227311577507;519.8596378977676;526.689253340529;545.9517725966145;24941.376465588368;33502.16244593883;34045.65954340456;34058.65941340589;34159.316813663776;36520.81739591305;36809.07977300569;37148.257034859285;37181.442278365845;37202.62797372032;7690.923090769091;7892.960535197316;7896.605169741519;7898.368130549571;7906.248906353887;7649.7705068847745;7779.727709530168;7781.2996830285265;7785.649645765926;7986.880196797053;7953.085395179571;8010.759677209693;8031.558264295461;8040.477368970998;8043;7919;7989.600519973978;7990.880136797953;7998.64006119726;8006.599670016505;7846.529208247466;7913.089994650573;7952.125266220711;7968.442209045369;7975.162607926142;37222.62777372219;37689;37731.245375092345;37745.24509509795;37750.81124594387;2846.5027831150983;2864.914052578426;2891.1182089462914;2921.050658535963;2921.9561706574204;27215.319617009536;28033.29916752077;28046.298842528897;28245.43509129806;28793.712062879313;3367.8147701876387;3376.8818091366684;3452.4993875887853;3535.611082780892;3549.893503194908;221670.9999999984;221869;222193;222376;222708;37565.81217093897;51219;51527.22709159365;51533.74233128886;51545.48454515482;36362;36372.818135909154;36577.63422365796;36630.81684591613;36636.81681591575;11168.944155279172;11354.432278386048;11358.829617555743;11360.375179365048;11368.204225704121;8974.326925480615;9053.90946090544;9055.049219831955;9055.456672599665;9098.363114581916;12733.490660373482;12775.425105870258;13062.477500899857;13114.409851556702;13197.340132993311;5237.319148510669;5412.675239485643;5466.562674985991;5492.1212605982855;5493.615446918758;706.5266271598042;766.9156392796788;796.446469703562;834.0325222741711;903.2773780975193;23724.508926562463;24143.51712965766;24175.32040421762;25535.87232063828;25951.74048259531;730.5288089182447;851.5742128935532;865.731623196811;893.7363477773943;938.5823308627595;12595.181313214613;12940.808390816555;13189.670258243621;13250.933745331211;13265.071444998757;311818;316925;317377;317536;317789;43331;43710.344344834855;43915.34126988098;43963.12073758571;43978.56021439809;903.6566104880103;905.6015353244683;1086.1528008153496;1094.4582431696201;1105.3699391347016;20287.69568456504;26906.73093269042;28875.278118047216;29131.85434072816;29269.121926342243;42194.36708449437;42245.36631950585;42708.145837083706;42760.144797104505;42798.57201427946;246641;247572;247866;247970;248409;22368.77631223667;27937.58093628638;28709.712902870702;28881.277968050967;29255;32847.67152328542;32971.83514082414;33081.33837323288;36954.815225923696;37135;30819.845900771248;31108.533371999893;31426.21434464065;31823.522647159847;32092.358152837278;31539.684603154594;31773.682263177074;31791.523127153574;31830.204244894063;31870.840645796623;24156.87921560381;28909.710902891544;28973.420531589672;29221.85389073041;33357.16607084842;27523.58714619242;29166.27084322909;29245.415091698473;29264.122076337742;29496.705032949394;22975.770242297363;23080;23170.304890853302;23338.76661233366;23400.76599234054 02:34:01 INFO - PROCESS | 5853 | |2;jquery.html;321.32361379296594;328.065014708082;332.9495441880867;334.8309103902529;337.73825285403825;14472.638184045418;15021.62445938852;15537.922310388447;15680.372785088583;16045.919770401131;14207.147571145739;14378.928105359484;14577.34401951912;14587.416503339853;14700.779488307684;4813.37426134602;4973.850784476454;4974.701517908937;4978.427480839696;4992.87517812054;4836.202026665614;4884.658073934826;4902.068606964684;4928.162212423897;4956.107900577895;4906.288588154715;4932.728699921503;4941.950580494185;4957.4298955620025;4960.33035540201;4817.277408388734;4891.75541222941;4918.631102667297;4921.901561968741;4922.876928076809;4279.529251782302;4382.649388048949;4406.339049142654;4415.470143582758;4417.602415782563;18358.173882175335;18453.261869525337;18732.531686707804;19136.712949305773;19174.808251917442;1876.5308672831793;1986.880787152761;2104.189886893557;2197.6593627987686;2249.8987545560326;12324.198927069801;12418.192817466836;12426.689332766662;12833.550825721055;12908.54820081302;1680.5210515003287;1736.6266252755718;1771.9468415947542;1772.1316554888142;1789.579448829524;34863.4770478443;38350.61649383526;38456;54680;56510;9031.412958157698;9178.816423671622;9349.532523373804;9362.906370936204;9434.952825235967;10609.098226650822;10909.290896091728;10924.890751092546;11403.315801051964;11435.771284574428;6582.506312026617;6705.832354191184;6726;6738.35985581369;6867.244603093655;6552.836179095465;6563.245226798884;6649.734010639617;6671.199456065303;6676.799696009128;5548.278723765885;5567.805126820542;5611.607187496836;5643.5767317451355;5737.110747834093;1621.7161996650539;1631.5921019745065;1650.909199994012;1656.8674506039488;1665.4004558359222;817.4808996287401;819.9631016604267;852.26705033671;894.5750768384966;967.3953778888194;15265;15528.14595197275;15919.522414327588;15936;16081.839181608268;823.3948048184579;824.9257566819015;866.27233124176;866.8916385451819;867.5835598912431;8931.285497160212;9278.48968306736;9394.107559781809;9406.435613863054;9418.905810941802;318567;325701;353545;354370;355387;57535;58674.41325586775;59598;60551;62106;914.9862752058724;924.902885197058;927.7866090799154;928.893177284621;931.0689310689446;13749.931250343685;14006.509772157926;14257.287135643384;14282.285885705465;14439.350229239919;28861.85569072141;29016.12951611455;29156.854215728785;29258.414831703674;29915.401691966475;36945.44581831221;38348.6165138345;38524;38736.80631596824;38846.80576597099;7012.123484564429;7017.298270173146;7043.119610048744;7083.610401427764;7221.711131554679;10080.193584513368;10204.132648724644;10287.94856025745;10511.632092876713;10698.89301106979;8770.386072975085;8864;8883.267762786194;8954.686585969459;9156.496392698198;9138.954305228697;9140.085991400807;9503.572339244613;9643.469609171563;9862.309638325249;8750.081241469554;9207.355485115977;9213.12475314844;9257.814843703223;9375.624975000923;6589.571677840925;6691.364320389555;6701;6753.020811982334;6962.617056061965;8669.089745576624;8790.42862213954;8812.91187088121;8845;9233.722988310361 02:34:01 INFO - PROCESS | 5853 | |3;mootools.html;1249.775040492711;1366.1598117157948;1391.227868532964;1519.7112548615762;1738.8782785205033;6822.7612033578835;7136.393406560449;7140.214576396592;7142.571445713254;7143.357097861185;7032.402245809112;7211.927880721191;7216.350528452438;7220.602866842321;7222.061132052839;1777.937772177974;1824.4435447188603;2056.105594066586;2149.3014770199707;2175.9347219583437;2096.982963262816;2113.9154433822705;2114.1754715660904;2115.3230966090855;2115.471132216946;2047.6109539187507;2060.577581595777;2061.608294424062;2115.428834214761;2177.6080305545074;2120.3320953899474;2144.5925274197853;2145.1741079684357;2146.1415433826514;2154.278316763878;2103.432073340205;2148.194427089841;2150.516133869882;2154.827613790893;2157.8165855902266;7342.632868356561;7428.182899881009;7430.071241094864;7436.256374362574;7453.962730186368;4226.387173859804;4345.80443880023;4346.413234213373;4356.912861742748;4367.061081867382;2758.7517123458783;2844.1751891951308;2868.268591509173;2877.985610071936;2883.1206482022976;888.4180861535705;919.5425201243306;946.0444950599875;953.4565297780268;961.1445813226235;10098.495075246208;10104.393736375767;10126.29115961883;10133.797324053477;10144.442055686934;3915.5105611798526;3993.3610622300293;4003.339448990942;4038.959610403917;4052.3111071117983;7793.298603125746;7810.218978102144;7890.013748281465;7898.684052637945;7904.249096335839;4281.807318670667;4291.420658211102;4293.484781826139;4300.032492689183;4305.138972205571;3330.9500357494658;3865.497485326946;3940.2907476653904;3959.8416063357145;3997.900052498711;3233.531137984979;3298.86804527821;3309.1396236978076;3314.5028245762846;3353.5137405076125;942.8350038743192;968.5641461342424;969.2488321550854;974.5614473486959;982.6708052802248;1050.7373156710823;1052.9631462898915;1083.2579682917226;1158.4960542164185;1161.4483120517687;6669.066330713704;6681.5656982296;6694.765683201064;6717.664116794141;6910.06714093601;984.7833476635129;994.2294721590825;995.4624502768569;1001.3491230699958;1035.063267742694;5106.234064890222;5168.586513078944;5195.532402083755;5207.114790485626;5388.838334849961;8729.60716767747;8921.107889211027;8952.68665596701;8988.10118988109;9057.411268267542;8022.719204827803;8228.259456648811;8845.115488451233;8894.46633201997;8900.198982091642;6717.429018533382;6782.491313151435;6788.864222715617;6798.796036118924;6839.179298484214;6760.526763126731;6783.287754785676;6840.760573379908;6871.244163142151;6872.484563657646;7730.961345193238;7756.612169391395;7820.3743700504965;7981.281684648409;7997.200279971957;8005;8048.356131509582;8355.331573473986;8357.247847693738;8360.456570323153;5165.896682066413;5759.8560035999435;6073.574849760651;6182.227221597301;6187.783427580013;6641.800745977628;6721.193456785217;6754.5609535380045;6763.12079429671;6774.96612516954;5739.827805165852;5791.942080579309;5818.33089194748;5922.082077278029;5999.790007349722;5636.85907852307;5784.82645520635;5861;5936.1689363488285;6083.969580152071;6231.186628643954;6252.406021427957;6349.8730025400155;6405.071264666504;6414.03789431589;6019.187409699634;6023.096535519532;6031.457168854824;6051.667158306335;6058.878822423615;5833.416658334133;5915.615484993462;5946.672932988728;5959.135925290895;5961.493273071837 02:34:01 INFO - PROCESS | 5853 | |4;prototype.html;284.7266624040921;290.7078386221847;291.54227862256255;291.6893508413541;293.44245932727813;5221.738913054346;5327.467253274675;5346.4118946915805;5366.838994830161;5373.516383525482;5194.71429071401;5221.451747566508;5221.5822734181265;5226.608004399666;5245.554127899133;3827.0241088522457;3938;4036.071703508195;4044.090079732066;4050.0482386639264;4012.6589239914642;4026;4033.495813023372;4036.5963403659694;4046.615571520701;3785.62143785622;3997.320455522568;4001.7999100045026;4004.6195611417015;4014.3777714454304;3926.9018274543077;3994.520657521087;3998.0804414984427;4013.7190396672245;4015.337469317559;3472.2361080562237;3472.722182225416;3485.790852548855;3490.0053484756977;3496.3881320768764;5015.648904576681;5034.270030845543;5035.899282014376;5042.3949126104735;5044.924326135111;4569.109023740372;4570.223062079454;4572.314152877095;4573.336866154389;4582.495925448198;5463.890722185534;5465.125579907196;5474.972625136888;5476.069068258365;5476.26070480484;3810.1808111256214;3813.370793819044;3814.7901865397394;3825.4261860720835;3827.349350610403;5518.641288316287;5751.913721294226;5756.625819321731;5758.049921762904;5764.625299355528;3729.8321575529167;3779.244151169777;3801.5248093988253;3801.847926082981;3805.4482100095884;3840.5007349044445;3843.8846834595006;3844.1735026969336;3845.3270677631303;3860.768353898775;4468.843590474317;4477.843275485342;4484.730916145042;4485.775711214426;4486.573775491323;5444;5446.304079480603;5446.373667028263;5452.863678408072;5458.4814442627885;1332.613542072788;1352.6347886070903;1356.328617334406;1356.5930220933878;1357.9253141077138;819.9221073997961;824.8432797768405;887.0287035695902;897.8249241397996;915.9267258619294;4763.499832517536;4787.521247875185;4798.304245884327;4810.302506136591;4817.807287708452;5592.916106258409;5614.6631202128;5617.297837770278;5625.915611265835;5634.098544232985;4776.95223047772;4780.593649539758;4782.832600858953;4783.473817880031;4791;2999.0702882106616;3029.1518374855077;3031.439183751013;3032.696730326994;3036.817790932551;5370.3287089113865;5376.623636345418;5382.838514844561;5385.434529374437;5386.165144402624;5602.327720673546;5751.396103409082;5768.134779782982;5772.826815195467;5785.190073389729;5351;5354.223637572608;5361.169018802092;5361.839144825583;5364.892702145935;5594;5657.971710141587;5662.66024038559;5667.773289068556;5675.035244008611;5484.095124304605;5489.505944464858;5491.423400542885;5492.670439773627;5506.256655351476;5357.330333708286;5362.356517217959;5362.570994320367;5367.275417818701;5370.979513892348;3675.7794532328144;3777.56557995823;3785.129420233417;3791.20384719201;3798.2213646203013;5617.101263797773;5662.546996240373;5666.376698563237;5667.518260947701;5669.943300566942;5264.763085661078;5367.141257398797;5406.351237851483;5439.48324909133;5509.779608815603;5499.752511137089;5500.394956554695;5505.064139096283;5514.117741161395;5517.531009864207;5353.946460535501;5358.276632654542;5361.597880158925;5364.14173732201;5368.8389348319615;5544.528715059265;5549.001179787677;5551.306086739158;5554.694491802989;5558.082916318762;5268.4731526848545;5412.458754124556;5427.538659214011;5429.511343979061;5432.0765469871 02:34:01 INFO - PROCESS | 5853 | |5;yui.html;629.6505439481089;647.543481845299;673.7035704290115;686.598339971117;703.6903762344568;10926.071283940864;10959.12327013839;11008.174386920973;11024.228304018712;11062.944685276572;10190.74523136922;11222.102231821455;11283.717907052327;11315.03822175114;11413.201075924668;763.0347610272995;767.808047988003;775.0544335910181;776.8679324514846;777.8211011467366;778.1246098139593;781.5115552779513;782.0419985517724;782.9217078292182;783.7570353190529;806.0569134113073;807.6527093349857;807.7092246791179;808.6361137488125;808.6886548678772;803.3813963248296;804.8309854930471;804.9476784009021;805.6374631415828;806.1817255485657;597.05068940385;597.2116805816324;597.4324391827738;597.7698586044404;598.9251343582052;10932.617358392497;10939.343639381583;10990.780184396268;10992.395418251994;11008.944955275252;11471.19701620887;11760.823587646191;12073.335966521838;12164.452599632948;12428.254304741655;9643.3731807433;9735.610575576968;9774.364666296739;9849.458279794608;9927.15619172364;3191.69678880506;3198.344339410415;3214.244652506659;3214.9196270093203;3220.6779322067605;36460.45309320362;36648.81675591605;37196.81401593002;40572.18855622871;42423.57576424258;9145.49699766506;9241.630334786667;9285.907140928639;9313.301502387349;9395.342326037111;15465.304061317043;15613.063216207063;15616.4534241301;15661.373545058297;15664.608384790472;5493.505584497414;6490.4807615390655;6569.244536878225;6617.966910165418;6692.59844409337;3743.4384842273876;3743.887683369503;3782.0544863784053;3786.3373909565717;3889.4943657324366;2499.387650025719;2521.1680145551923;2524.4698613291416;2527.0144643589015;2529.190658989106;489.51782494243145;491.5698763581866;496.92546118081856;503.89418222173754;506.8530126263416;447.77834971689225;452.2560388161456;483.13277666587857;503.24764477106226;528.2578373084596;6870.828229294308;6911.447084233249;7067.84513880244;7331.156916954618;7352.5220860643885;515.7436216552583;515.9613029022838;516.602216293452;532.5366930770255;536.9006733754268;3346.330733853239;3402.1154499829727;3456.187795867969;3458.8270586470576;3482.7736197147105;48109.27836082462;48477;48852.91632713236;48998.75500622474;49054.50945490571;43326.56673433226;43517.12965740667;43675.56324436778;43869.78065109654;44089.338659920126;34061;41046.1790764183;41819;43783.78108109439;44363;7402.851942961218;7458;7469.514481558681;7489.13874904393;7489.812754681177;31400.37199256048;31725.682743173194;31834.204144896565;32008;32122.35755284928;35214.29571408609;35478.645213547534;35719.821400892826;38232.42651360288;39173;8117.55353455542;8478.872816907628;9445.669401570913;9468.621255149717;9721.854172187564;10626.681199564026;10682.145428365557;11020.173486988348;11084.279521831055;11262.662120136409;9813.754656133653;10156.339837910513;10330.845037324296;10482.056614904695;10573.04842564173;9368.016358282282;9391;10032.31558390312;10102.191824654157;10507.42209178472;9468.763280918032;9485.715428537154;9605.807883842144;9660.613575456902;9971.750706232113;8438.493690378597;8956.731298060808;9131.589078491352;9141.085891411072;9400.717978460658;8857.335699822668;9020.323475739215;9174.816503670023;9193.356465047382;9209.861852072358 02:34:01 INFO - PROCESS | 5853 | __end_tp_report 02:34:01 INFO - PROCESS | 5853 | __start_cc_report 02:34:01 INFO - PROCESS | 5853 | _x_x_mozilla_cycle_collect,887 02:34:01 INFO - PROCESS | 5853 | __end_cc_report 02:34:01 INFO - PROCESS | 5853 | __startTimestamp1457519641607__endTimestamp 02:34:01 INFO - PROCESS | 5853 | 02:34:01 INFO - PROCESS | 5853 | ------- Summary: start ------- 02:34:01 INFO - PROCESS | 5853 | Number of tests: 6 02:34:01 INFO - PROCESS | 5853 | 02:34:01 INFO - PROCESS | 5853 | [#0] dojo.html Cycles:165 Average:4558.00 Median:4728.88 stddev:468.29 (9.9%) stddev-sans-first:443.18 02:34:01 INFO - PROCESS | 5853 | Values: 2576.5 2626.0 2658.2 2664.4 2691.7 4500.5 4621.7 4630.7 4634.7 4638.4 4554.3 4589.8 4599.2 4599.4 4664.3 4178.0 4234.6 4292.4 4360.8 4392.1 4121.2 4290.3 4340.0 4343.0 4358.9 4190.1 4261.3 4268.9 4311.1 4315.6 4261.3 4272.9 4276.1 4288.7 4309.3 4171.9 4230.2 4247.3 4253.5 4293.2 4493.3 4598.0 4614.4 4621.3 4666.7 4908.2 4912.6 4913.6 4913.8 4918.4 4832.5 4928.3 4938.8 5000.6 5035.7 4580.2 4587.2 4590.0 4590.1 4618.3 5069.1 5074.1 5075.5 5082.0 5090.8 4728.9 4777.7 4847.5 4867.4 4897.7 4894.5 4905.7 4912.0 4914.6 4960.6 4874.0 4878.6 4879.6 4881.1 4927.0 4706.6 4784.9 4874.2 4918.9 4929.0 4114.0 4119.1 4120.2 4143.3 4161.5 3544.3 3614.5 3621.5 3641.8 3651.9 4205.7 4215.3 4270.7 4302.2 4307.0 4832.2 4855.9 4859.2 4861.7 4908.7 4189.1 4195.2 4201.2 4213.1 4239.4 4351.5 4404.5 4410.0 4426.4 4455.7 4726.3 4740.5 4740.6 4744.5 4763.2 4760.2 4909.7 4971.9 4974.1 5006.5 4731.2 4749.8 4751.2 4752.1 4801.2 4861.0 4883.8 4887.3 4889.0 4924.3 4844.5 4901.7 4903.2 4990.1 4992.8 4814.0 4830.8 4841.3 4841.3 4884.1 4770.3 4773.4 4777.7 4790.0 4826.4 4515.0 4608.2 4657.4 4714.8 4718.7 4828.1 4828.5 4839.1 4846.1 4883.7 4734.7 4735.9 4737.5 4746.4 4763.3 02:34:01 INFO - PROCESS | 5853 | 02:34:01 INFO - PROCESS | 5853 | [#1] ext.html Cycles:180 Average:40314.10 Median:34052.16 stddev:69467.53 (204.0%) stddev-sans-first:69598.08 02:34:01 INFO - PROCESS | 5853 | Values: 498.5 513.8 519.9 526.7 546.0 24941.4 33502.2 34045.7 34058.7 34159.3 36520.8 36809.1 37148.3 37181.4 37202.6 7690.9 7893.0 7896.6 7898.4 7906.2 7649.8 7779.7 7781.3 7785.6 7986.9 7953.1 8010.8 8031.6 8040.5 8043.0 7919.0 7989.6 7990.9 7998.6 8006.6 7846.5 7913.1 7952.1 7968.4 7975.2 37222.6 37689.0 37731.2 37745.2 37750.8 2846.5 2864.9 2891.1 2921.1 2922.0 27215.3 28033.3 28046.3 28245.4 28793.7 3367.8 3376.9 3452.5 3535.6 3549.9 221671.0 221869.0 222193.0 222376.0 222708.0 37565.8 51219.0 51527.2 51533.7 51545.5 36362.0 36372.8 36577.6 36630.8 36636.8 11168.9 11354.4 11358.8 11360.4 11368.2 8974.3 9053.9 9055.0 9055.5 9098.4 12733.5 12775.4 13062.5 13114.4 13197.3 5237.3 5412.7 5466.6 5492.1 5493.6 706.5 766.9 796.4 834.0 903.3 23724.5 24143.5 24175.3 25535.9 25951.7 730.5 851.6 865.7 893.7 938.6 12595.2 12940.8 13189.7 13250.9 13265.1 311818.0 316925.0 317377.0 317536.0 317789.0 43331.0 43710.3 43915.3 43963.1 43978.6 903.7 905.6 1086.2 1094.5 1105.4 20287.7 26906.7 28875.3 29131.9 29269.1 42194.4 42245.4 42708.1 42760.1 42798.6 246641.0 247572.0 247866.0 247970.0 248409.0 22368.8 27937.6 28709.7 28881.3 29255.0 32847.7 32971.8 33081.3 36954.8 37135.0 30819.8 31108.5 31426.2 31823.5 32092.4 31539.7 31773.7 31791.5 31830.2 31870.8 24156.9 28909.7 28973.4 29221.9 33357.2 27523.6 29166.3 29245.4 29264.1 29496.7 22975.8 23080.0 23170.3 23338.8 23400.8 02:34:01 INFO - PROCESS | 5853 | 02:34:01 INFO - PROCESS | 5853 | [#2] jquery.html Cycles:180 Average:20724.32 Median:4920.27 stddev:55899.41 (1136.1%) stddev-sans-first:56035.23 02:34:01 INFO - PROCESS | 5853 | Values: 321.3 328.1 332.9 334.8 337.7 14472.6 15021.6 15537.9 15680.4 16045.9 14207.1 14378.9 14577.3 14587.4 14700.8 4813.4 4973.9 4974.7 4978.4 4992.9 4836.2 4884.7 4902.1 4928.2 4956.1 4906.3 4932.7 4942.0 4957.4 4960.3 4817.3 4891.8 4918.6 4921.9 4922.9 4279.5 4382.6 4406.3 4415.5 4417.6 18358.2 18453.3 18732.5 19136.7 19174.8 1876.5 1986.9 2104.2 2197.7 2249.9 12324.2 12418.2 12426.7 12833.6 12908.5 1680.5 1736.6 1771.9 1772.1 1789.6 34863.5 38350.6 38456.0 54680.0 56510.0 9031.4 9178.8 9349.5 9362.9 9435.0 10609.1 10909.3 10924.9 11403.3 11435.8 6582.5 6705.8 6726.0 6738.4 6867.2 6552.8 6563.2 6649.7 6671.2 6676.8 5548.3 5567.8 5611.6 5643.6 5737.1 1621.7 1631.6 1650.9 1656.9 1665.4 817.5 820.0 852.3 894.6 967.4 15265.0 15528.1 15919.5 15936.0 16081.8 823.4 824.9 866.3 866.9 867.6 8931.3 9278.5 9394.1 9406.4 9418.9 318567.0 325701.0 353545.0 354370.0 355387.0 57535.0 58674.4 59598.0 60551.0 62106.0 915.0 924.9 927.8 928.9 931.1 13749.9 14006.5 14257.3 14282.3 14439.4 28861.9 29016.1 29156.9 29258.4 29915.4 36945.4 38348.6 38524.0 38736.8 38846.8 7012.1 7017.3 7043.1 7083.6 7221.7 10080.2 10204.1 10287.9 10511.6 10698.9 8770.4 8864.0 8883.3 8954.7 9156.5 9139.0 9140.1 9503.6 9643.5 9862.3 8750.1 9207.4 9213.1 9257.8 9375.6 6589.6 6691.4 6701.0 6753.0 6962.6 8669.1 8790.4 8812.9 8845.0 9233.7 02:34:01 INFO - PROCESS | 5853 | 02:34:01 INFO - PROCESS | 5853 | [#3] mootools.html Cycles:180 Average:4998.64 Median:5960.31 stddev:2614.79 (43.9%) stddev-sans-first:2606.94 02:34:01 INFO - PROCESS | 5853 | Values: 1249.8 1366.2 1391.2 1519.7 1738.9 6822.8 7136.4 7140.2 7142.6 7143.4 7032.4 7211.9 7216.4 7220.6 7222.1 1777.9 1824.4 2056.1 2149.3 2175.9 2097.0 2113.9 2114.2 2115.3 2115.5 2047.6 2060.6 2061.6 2115.4 2177.6 2120.3 2144.6 2145.2 2146.1 2154.3 2103.4 2148.2 2150.5 2154.8 2157.8 7342.6 7428.2 7430.1 7436.3 7454.0 4226.4 4345.8 4346.4 4356.9 4367.1 2758.8 2844.2 2868.3 2878.0 2883.1 888.4 919.5 946.0 953.5 961.1 10098.5 10104.4 10126.3 10133.8 10144.4 3915.5 3993.4 4003.3 4039.0 4052.3 7793.3 7810.2 7890.0 7898.7 7904.2 4281.8 4291.4 4293.5 4300.0 4305.1 3331.0 3865.5 3940.3 3959.8 3997.9 3233.5 3298.9 3309.1 3314.5 3353.5 942.8 968.6 969.2 974.6 982.7 1050.7 1053.0 1083.3 1158.5 1161.4 6669.1 6681.6 6694.8 6717.7 6910.1 984.8 994.2 995.5 1001.3 1035.1 5106.2 5168.6 5195.5 5207.1 5388.8 8729.6 8921.1 8952.7 8988.1 9057.4 8022.7 8228.3 8845.1 8894.5 8900.2 6717.4 6782.5 6788.9 6798.8 6839.2 6760.5 6783.3 6840.8 6871.2 6872.5 7731.0 7756.6 7820.4 7981.3 7997.2 8005.0 8048.4 8355.3 8357.2 8360.5 5165.9 5759.9 6073.6 6182.2 6187.8 6641.8 6721.2 6754.6 6763.1 6775.0 5739.8 5791.9 5818.3 5922.1 5999.8 5636.9 5784.8 5861.0 5936.2 6084.0 6231.2 6252.4 6349.9 6405.1 6414.0 6019.2 6023.1 6031.5 6051.7 6058.9 5833.4 5915.6 5946.7 5959.1 5961.5 02:34:01 INFO - PROCESS | 5853 | 02:34:01 INFO - PROCESS | 5853 | [#4] prototype.html Cycles:180 Average:4514.19 Median:5255.16 stddev:1349.32 (25.7%) stddev-sans-first:1315.23 02:34:01 INFO - PROCESS | 5853 | Values: 284.7 290.7 291.5 291.7 293.4 5221.7 5327.5 5346.4 5366.8 5373.5 5194.7 5221.5 5221.6 5226.6 5245.6 3827.0 3938.0 4036.1 4044.1 4050.0 4012.7 4026.0 4033.5 4036.6 4046.6 3785.6 3997.3 4001.8 4004.6 4014.4 3926.9 3994.5 3998.1 4013.7 4015.3 3472.2 3472.7 3485.8 3490.0 3496.4 5015.6 5034.3 5035.9 5042.4 5044.9 4569.1 4570.2 4572.3 4573.3 4582.5 5463.9 5465.1 5475.0 5476.1 5476.3 3810.2 3813.4 3814.8 3825.4 3827.3 5518.6 5751.9 5756.6 5758.0 5764.6 3729.8 3779.2 3801.5 3801.8 3805.4 3840.5 3843.9 3844.2 3845.3 3860.8 4468.8 4477.8 4484.7 4485.8 4486.6 5444.0 5446.3 5446.4 5452.9 5458.5 1332.6 1352.6 1356.3 1356.6 1357.9 819.9 824.8 887.0 897.8 915.9 4763.5 4787.5 4798.3 4810.3 4817.8 5592.9 5614.7 5617.3 5625.9 5634.1 4777.0 4780.6 4782.8 4783.5 4791.0 2999.1 3029.2 3031.4 3032.7 3036.8 5370.3 5376.6 5382.8 5385.4 5386.2 5602.3 5751.4 5768.1 5772.8 5785.2 5351.0 5354.2 5361.2 5361.8 5364.9 5594.0 5658.0 5662.7 5667.8 5675.0 5484.1 5489.5 5491.4 5492.7 5506.3 5357.3 5362.4 5362.6 5367.3 5371.0 3675.8 3777.6 3785.1 3791.2 3798.2 5617.1 5662.5 5666.4 5667.5 5669.9 5264.8 5367.1 5406.4 5439.5 5509.8 5499.8 5500.4 5505.1 5514.1 5517.5 5353.9 5358.3 5361.6 5364.1 5368.8 5544.5 5549.0 5551.3 5554.7 5558.1 5268.5 5412.5 5427.5 5429.5 5432.1 02:34:01 INFO - PROCESS | 5853 | 02:34:01 INFO - PROCESS | 5853 | [#5] yui.html Cycles:180 Average:11890.33 Median:24773.04 stddev:13519.70 (54.6%) stddev-sans-first:13531.18 02:34:01 INFO - PROCESS | 5853 | Values: 629.7 647.5 673.7 686.6 703.7 10926.1 10959.1 11008.2 11024.2 11062.9 10190.7 11222.1 11283.7 11315.0 11413.2 763.0 767.8 775.1 776.9 777.8 778.1 781.5 782.0 782.9 783.8 806.1 807.7 807.7 808.6 808.7 803.4 804.8 804.9 805.6 806.2 597.1 597.2 597.4 597.8 598.9 10932.6 10939.3 10990.8 10992.4 11008.9 11471.2 11760.8 12073.3 12164.5 12428.3 9643.4 9735.6 9774.4 9849.5 9927.2 3191.7 3198.3 3214.2 3214.9 3220.7 36460.5 36648.8 37196.8 40572.2 42423.6 9145.5 9241.6 9285.9 9313.3 9395.3 15465.3 15613.1 15616.5 15661.4 15664.6 5493.5 6490.5 6569.2 6618.0 6692.6 3743.4 3743.9 3782.1 3786.3 3889.5 2499.4 2521.2 2524.5 2527.0 2529.2 489.5 491.6 496.9 503.9 506.9 447.8 452.3 483.1 503.2 528.3 6870.8 6911.4 7067.8 7331.2 7352.5 515.7 516.0 516.6 532.5 536.9 3346.3 3402.1 3456.2 3458.8 3482.8 48109.3 48477.0 48852.9 48998.8 49054.5 43326.6 43517.1 43675.6 43869.8 44089.3 34061.0 41046.2 41819.0 43783.8 44363.0 7402.9 7458.0 7469.5 7489.1 7489.8 31400.4 31725.7 31834.2 32008.0 32122.4 35214.3 35478.6 35719.8 38232.4 39173.0 8117.6 8478.9 9445.7 9468.6 9721.9 10626.7 10682.1 11020.2 11084.3 11262.7 9813.8 10156.3 10330.8 10482.1 10573.0 9368.0 9391.0 10032.3 10102.2 10507.4 9468.8 9485.7 9605.8 9660.6 9971.8 8438.5 8956.7 9131.6 9141.1 9400.7 8857.3 9020.3 9174.8 9193.4 9209.9 02:34:01 INFO - PROCESS | 5853 | -------- Summary: end -------- 02:34:01 INFO - PROCESS | 5853 | 02:34:02 INFO - TEST-INFO | 5853: exit 0 02:34:02 INFO - TEST-OK | dromaeo_css | took 1119361ms 02:34:02 INFO - TEST-START | kraken 02:34:02 INFO - operating with platform_type : linux_ 02:34:02 INFO - Initialising browser for kraken test... 02:34:02 INFO - TEST-INFO | started process 6035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpypE2ve/profile http://localhost:39671/getInfo.html) 02:34:07 INFO - PROCESS | 6035 | __metrics Screen width/height:1600/1200 02:34:07 INFO - PROCESS | 6035 | colorDepth:24 02:34:07 INFO - PROCESS | 6035 | Browser inner width/height: 1024/697 02:34:07 INFO - PROCESS | 6035 | __metrics 02:34:08 ERROR - PROCESS | 6035 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:34:09 INFO - TEST-INFO | 6035: exit 0 02:34:09 INFO - Browser initialized. 02:34:09 INFO - Running cycle 1/1 for kraken test... 02:34:09 INFO - TEST-INFO | started process 6116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpypE2ve/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:21 INFO - PROCESS | 6116 | RSS: Main: 154501120 02:34:21 INFO - PROCESS | 6116 | 02:34:24 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39671/tests/kraken/driver.html?testName=audio-beat-detection) 02:34:24 INFO - PROCESS | 6116 | RSS: Main: 195166208 02:34:24 INFO - PROCESS | 6116 | 02:34:27 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39671/tests/kraken/driver.html?testName=audio-dft) 02:34:28 INFO - PROCESS | 6116 | RSS: Main: 184934400 02:34:28 INFO - PROCESS | 6116 | 02:34:31 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39671/tests/kraken/driver.html?testName=audio-fft) 02:34:31 INFO - PROCESS | 6116 | RSS: Main: 171315200 02:34:31 INFO - PROCESS | 6116 | 02:34:33 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39671/tests/kraken/driver.html?testName=audio-oscillator) 02:34:34 INFO - PROCESS | 6116 | RSS: Main: 172756992 02:34:34 INFO - PROCESS | 6116 | 02:34:36 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39671/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:34:37 INFO - PROCESS | 6116 | RSS: Main: 173375488 02:34:37 INFO - PROCESS | 6116 | 02:34:40 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39671/tests/kraken/driver.html?testName=imaging-darkroom) 02:34:41 INFO - PROCESS | 6116 | RSS: Main: 174182400 02:34:41 INFO - PROCESS | 6116 | 02:34:44 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39671/tests/kraken/driver.html?testName=imaging-desaturate) 02:34:45 INFO - PROCESS | 6116 | RSS: Main: 176959488 02:34:45 INFO - PROCESS | 6116 | 02:34:47 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39671/tests/kraken/driver.html?testName=json-parse-financial) 02:34:48 INFO - PROCESS | 6116 | RSS: Main: 175120384 02:34:48 INFO - PROCESS | 6116 | 02:34:50 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39671/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:34:50 INFO - PROCESS | 6116 | RSS: Main: 185733120 02:34:50 INFO - PROCESS | 6116 | 02:34:52 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:34:53 INFO - PROCESS | 6116 | RSS: Main: 182472704 02:34:53 INFO - PROCESS | 6116 | 02:34:55 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:34:56 INFO - PROCESS | 6116 | RSS: Main: 192851968 02:34:56 INFO - PROCESS | 6116 | 02:34:58 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:34:59 INFO - PROCESS | 6116 | RSS: Main: 196411392 02:34:59 INFO - PROCESS | 6116 | 02:35:01 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:35:02 INFO - PROCESS | 6116 | RSS: Main: 195678208 02:35:02 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39671/tests/kraken/driver.html?testName=ai-astar) 02:35:04 INFO - PROCESS | 6116 | RSS: Main: 257777664 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | __start_tp_report 02:35:04 INFO - PROCESS | 6116 | _x_x_mozilla_page_load 02:35:04 INFO - PROCESS | 6116 | _x_x_mozilla_page_load_details 02:35:04 INFO - PROCESS | 6116 | |i|pagename|runs| 02:35:04 INFO - PROCESS | 6116 | |0;ai-astar;111;113;107;114;115;112;101;114;114;113 02:35:04 INFO - PROCESS | 6116 | |1;audio-beat-detection;166;136;158;168;133;154;150;129;167;140 02:35:04 INFO - PROCESS | 6116 | |2;audio-dft;161;163;163;164;161;161;163;163;162;162 02:35:04 INFO - PROCESS | 6116 | |3;audio-fft;74;73;99;94;72;73;76;108;92;72 02:35:04 INFO - PROCESS | 6116 | |4;audio-oscillator;95;97;139;93;95;94;134;96;94;139 02:35:04 INFO - PROCESS | 6116 | |5;imaging-gaussian-blur;117;117;116;117;116;117;116;118;118;117 02:35:04 INFO - PROCESS | 6116 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;145;147 02:35:04 INFO - PROCESS | 6116 | |7;imaging-desaturate;96;95;95;96;96;96;95;96;96;95 02:35:04 INFO - PROCESS | 6116 | |8;json-parse-financial;67;68;67;67;68;67;68;76;65;65 02:35:04 INFO - PROCESS | 6116 | |9;json-stringify-tinderbox;69;71;71;69;70;70;70;70;70;71 02:35:04 INFO - PROCESS | 6116 | |10;stanford-crypto-aes;81;87;84;86;83;82;84;83;83;83 02:35:04 INFO - PROCESS | 6116 | |11;stanford-crypto-ccm;119;127;117;137;127;135;125;126;127;123 02:35:04 INFO - PROCESS | 6116 | |12;stanford-crypto-pbkdf2;146;143;142;148;156;140;143;146;151;148 02:35:04 INFO - PROCESS | 6116 | |13;stanford-crypto-sha256-iterative;71;70;70;70;71;71;69;70;70;72 02:35:04 INFO - PROCESS | 6116 | __end_tp_report 02:35:04 INFO - PROCESS | 6116 | __start_cc_report 02:35:04 INFO - PROCESS | 6116 | _x_x_mozilla_cycle_collect,1144 02:35:04 INFO - PROCESS | 6116 | __end_cc_report 02:35:04 INFO - PROCESS | 6116 | __startTimestamp1457519704587__endTimestamp 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | ------- Summary: start ------- 02:35:04 INFO - PROCESS | 6116 | Number of tests: 14 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.50 stddev:4.30 (3.8%) stddev-sans-first:4.56 02:35:04 INFO - PROCESS | 6116 | Values: 111.0 113.0 107.0 114.0 115.0 112.0 101.0 114.0 114.0 113.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:156.00 stddev:14.81 (9.5%) stddev-sans-first:14.55 02:35:04 INFO - PROCESS | 6116 | Values: 166.0 136.0 158.0 168.0 133.0 154.0 150.0 129.0 167.0 140.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 02:35:04 INFO - PROCESS | 6116 | Values: 161.0 163.0 163.0 164.0 161.0 161.0 163.0 163.0 162.0 162.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.00 stddev:13.56 (18.1%) stddev-sans-first:13.96 02:35:04 INFO - PROCESS | 6116 | Values: 74.0 73.0 99.0 94.0 72.0 73.0 76.0 108.0 92.0 72.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:94.50 stddev:20.59 (21.8%) stddev-sans-first:21.33 02:35:04 INFO - PROCESS | 6116 | Values: 95.0 97.0 139.0 93.0 95.0 94.0 134.0 96.0 94.0 139.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 02:35:04 INFO - PROCESS | 6116 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 116.0 118.0 118.0 117.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 02:35:04 INFO - PROCESS | 6116 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:35:04 INFO - PROCESS | 6116 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:67.50 stddev:3.08 (4.6%) stddev-sans-first:3.26 02:35:04 INFO - PROCESS | 6116 | Values: 67.0 68.0 67.0 67.0 68.0 67.0 68.0 76.0 65.0 65.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 02:35:04 INFO - PROCESS | 6116 | Values: 69.0 71.0 71.0 69.0 70.0 70.0 70.0 70.0 70.0 71.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:1.78 (2.1%) stddev-sans-first:1.62 02:35:04 INFO - PROCESS | 6116 | Values: 81.0 87.0 84.0 86.0 83.0 82.0 84.0 83.0 83.0 83.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:127.00 stddev:6.18 (4.9%) stddev-sans-first:5.97 02:35:04 INFO - PROCESS | 6116 | Values: 119.0 127.0 117.0 137.0 127.0 135.0 125.0 126.0 127.0 123.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:147.00 stddev:4.74 (3.2%) stddev-sans-first:5.02 02:35:04 INFO - PROCESS | 6116 | Values: 146.0 143.0 142.0 148.0 156.0 140.0 143.0 146.0 151.0 148.0 02:35:04 INFO - PROCESS | 6116 | 02:35:04 INFO - PROCESS | 6116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 02:35:04 INFO - PROCESS | 6116 | Values: 71.0 70.0 70.0 70.0 71.0 71.0 69.0 70.0 70.0 72.0 02:35:04 INFO - PROCESS | 6116 | -------- Summary: end -------- 02:35:04 INFO - PROCESS | 6116 | 02:35:05 INFO - TEST-INFO | 6116: exit 0 02:35:05 INFO - TEST-OK | kraken | took 63199ms 02:35:05 INFO - SUITE-END | took 1182s 02:35:05 INFO - Completed test suite (00:19:42) 02:35:05 INFO - javascript benchmark 02:35:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2576.5362234797735, 2626.0, 2658.202539238228, 2664.3871909460836, 2691.7442842929922, 4500.459944806627, 4621.6533759968015, 4630.6527010474265, 4634.675572709907, 4638.350630911675, 4554.2713165893465, 4589.770511474429, 4599.241125214336, 4599.40207772989, 4664.2770370592525, 4178.039051018268, 4234.576542345764, 4292.441982542266, 4360.847370342039, 4392.12157568486, 4121.1757648470275, 4290.292101803198, 4340.0, 4343.04453020335, 4358.934615980763, 4190.0572371216385, 4261.31818908973, 4268.893277668083, 4311.116221174651, 4315.633171180453, 4261.339492378686, 4272.893177670552, 4276.102018576103, 4288.656907447428, 4309.267424537836, 4171.91656166878, 4230.2174097792, 4247.320428731388, 4253.510846252659, 4293.248681480728, 4493.348464472666, 4597.977010114928, 4614.446266448048, 4621.3299071634765, 4666.6500012498855, 4908.239222920453, 4912.582430493412, 4913.631477639191, 4913.828016019422, 4918.385201849769, 4832.492588278251, 4928.310036594879, 4938.80244790208, 5000.599952003831, 5035.697858128524, 4580.198465268565, 4587.220172570671, 4589.954100458986, 4590.127875703605, 4618.261078227468, 5069.138246498104, 5074.112030394666, 5075.5178258065425, 5081.958198569285, 5090.796368145307, 4728.881777955578, 4777.71333719971, 4847.515248475195, 4867.3915760529935, 4897.706137631753, 4894.486078961729, 4905.730184839868, 4912.04215178044, 4914.631402644816, 4960.578350840146, 4874.0, 4878.585320247747, 4879.609631229493, 4881.121398148367, 4927.0, 4706.599939005155, 4784.856454306377, 4874.2444921037295, 4918.877028074256, 4928.950710492849, 4114.0, 4119.114390406077, 4120.196561670446, 4143.274926887782, 4161.479815023122, 3544.326577950181, 3614.530111085595, 3621.511096002006, 3641.8361173747244, 3651.908702282464, 4205.684573656988, 4215.283401821697, 4270.701050926467, 4302.182585308781, 4307.030918043415, 4832.202686556749, 4855.854324370274, 4859.222524396079, 4861.683990540603, 4908.730019848871, 4189.05746207107, 4195.244855925963, 4201.222773786859, 4213.115245798355, 4239.364095385655, 4351.4995775485595, 4404.493483249467, 4409.9559004410185, 4426.3581780641625, 4455.6658250631335, 4726.338312636233, 4740.454847692559, 4740.6444516660695, 4744.4543877454535, 4763.2140696784645, 4760.238361862085, 4909.68087074339, 4971.850844474671, 4974.104661160881, 5006.524380183877, 4731.219348807408, 4749.786259618395, 4751.192297309397, 4752.097101550694, 4801.231802911518, 4860.975695121501, 4883.80464781419, 4887.34020907173, 4889.0, 4924.285978533164, 4844.467108617979, 4901.730404827768, 4903.239997800347, 4990.101781679333, 4992.775325110306, 4814.0, 4830.806767729251, 4841.273808928689, 4841.298011788201, 4884.072026314989, 4770.308305295644, 4773.427188737373, 4777.737224452689, 4790.0, 4826.372571565815, 4515.0, 4608.216603177535, 4657.417822772153, 4714.764261786965, 4718.693284936468, 4828.058528586892, 4828.5412885775795, 4839.080574690797, 4846.103470857903, 4883.658143929891, 4734.668573199843, 4735.928961065518, 4737.455192652889, 4746.43042834862, 4763.285507173813], "unit": "score", "name": "dojo.html", "value": 4529.03596684093}, {"lowerIsBetter": false, "replicates": [498.4865588443902, 513.8227311577507, 519.8596378977676, 526.689253340529, 545.9517725966145, 24941.376465588368, 33502.16244593883, 34045.65954340456, 34058.65941340589, 34159.316813663776, 36520.81739591305, 36809.07977300569, 37148.257034859285, 37181.442278365845, 37202.62797372032, 7690.923090769091, 7892.960535197316, 7896.605169741519, 7898.368130549571, 7906.248906353887, 7649.7705068847745, 7779.727709530168, 7781.2996830285265, 7785.649645765926, 7986.880196797053, 7953.085395179571, 8010.759677209693, 8031.558264295461, 8040.477368970998, 8043.0, 7919.0, 7989.600519973978, 7990.880136797953, 7998.64006119726, 8006.599670016505, 7846.529208247466, 7913.089994650573, 7952.125266220711, 7968.442209045369, 7975.162607926142, 37222.62777372219, 37689.0, 37731.245375092345, 37745.24509509795, 37750.81124594387, 2846.5027831150983, 2864.914052578426, 2891.1182089462914, 2921.050658535963, 2921.9561706574204, 27215.319617009536, 28033.29916752077, 28046.298842528897, 28245.43509129806, 28793.712062879313, 3367.8147701876387, 3376.8818091366684, 3452.4993875887853, 3535.611082780892, 3549.893503194908, 221670.9999999984, 221869.0, 222193.0, 222376.0, 222708.0, 37565.81217093897, 51219.0, 51527.22709159365, 51533.74233128886, 51545.48454515482, 36362.0, 36372.818135909154, 36577.63422365796, 36630.81684591613, 36636.81681591575, 11168.944155279172, 11354.432278386048, 11358.829617555743, 11360.375179365048, 11368.204225704121, 8974.326925480615, 9053.90946090544, 9055.049219831955, 9055.456672599665, 9098.363114581916, 12733.490660373482, 12775.425105870258, 13062.477500899857, 13114.409851556702, 13197.340132993311, 5237.319148510669, 5412.675239485643, 5466.562674985991, 5492.1212605982855, 5493.615446918758, 706.5266271598042, 766.9156392796788, 796.446469703562, 834.0325222741711, 903.2773780975193, 23724.508926562463, 24143.51712965766, 24175.32040421762, 25535.87232063828, 25951.74048259531, 730.5288089182447, 851.5742128935532, 865.731623196811, 893.7363477773943, 938.5823308627595, 12595.181313214613, 12940.808390816555, 13189.670258243621, 13250.933745331211, 13265.071444998757, 311818.0, 316925.0, 317377.0, 317536.0, 317789.0, 43331.0, 43710.344344834855, 43915.34126988098, 43963.12073758571, 43978.56021439809, 903.6566104880103, 905.6015353244683, 1086.1528008153496, 1094.4582431696201, 1105.3699391347016, 20287.69568456504, 26906.73093269042, 28875.278118047216, 29131.85434072816, 29269.121926342243, 42194.36708449437, 42245.36631950585, 42708.145837083706, 42760.144797104505, 42798.57201427946, 246641.0, 247572.0, 247866.0, 247970.0, 248409.0, 22368.77631223667, 27937.58093628638, 28709.712902870702, 28881.277968050967, 29255.0, 32847.67152328542, 32971.83514082414, 33081.33837323288, 36954.815225923696, 37135.0, 30819.845900771248, 31108.533371999893, 31426.21434464065, 31823.522647159847, 32092.358152837278, 31539.684603154594, 31773.682263177074, 31791.523127153574, 31830.204244894063, 31870.840645796623, 24156.87921560381, 28909.710902891544, 28973.420531589672, 29221.85389073041, 33357.16607084842, 27523.58714619242, 29166.27084322909, 29245.415091698473, 29264.122076337742, 29496.705032949394, 22975.770242297363, 23080.0, 23170.304890853302, 23338.76661233366, 23400.76599234054], "unit": "score", "name": "ext.html", "value": 15622.918493639927}, {"lowerIsBetter": false, "replicates": [321.32361379296594, 328.065014708082, 332.9495441880867, 334.8309103902529, 337.73825285403825, 14472.638184045418, 15021.62445938852, 15537.922310388447, 15680.372785088583, 16045.919770401131, 14207.147571145739, 14378.928105359484, 14577.34401951912, 14587.416503339853, 14700.779488307684, 4813.37426134602, 4973.850784476454, 4974.701517908937, 4978.427480839696, 4992.87517812054, 4836.202026665614, 4884.658073934826, 4902.068606964684, 4928.162212423897, 4956.107900577895, 4906.288588154715, 4932.728699921503, 4941.950580494185, 4957.4298955620025, 4960.33035540201, 4817.277408388734, 4891.75541222941, 4918.631102667297, 4921.901561968741, 4922.876928076809, 4279.529251782302, 4382.649388048949, 4406.339049142654, 4415.470143582758, 4417.602415782563, 18358.173882175335, 18453.261869525337, 18732.531686707804, 19136.712949305773, 19174.808251917442, 1876.5308672831793, 1986.880787152761, 2104.189886893557, 2197.6593627987686, 2249.8987545560326, 12324.198927069801, 12418.192817466836, 12426.689332766662, 12833.550825721055, 12908.54820081302, 1680.5210515003287, 1736.6266252755718, 1771.9468415947542, 1772.1316554888142, 1789.579448829524, 34863.4770478443, 38350.61649383526, 38456.0, 54680.0, 56510.0, 9031.412958157698, 9178.816423671622, 9349.532523373804, 9362.906370936204, 9434.952825235967, 10609.098226650822, 10909.290896091728, 10924.890751092546, 11403.315801051964, 11435.771284574428, 6582.506312026617, 6705.832354191184, 6726.0, 6738.35985581369, 6867.244603093655, 6552.836179095465, 6563.245226798884, 6649.734010639617, 6671.199456065303, 6676.799696009128, 5548.278723765885, 5567.805126820542, 5611.607187496836, 5643.5767317451355, 5737.110747834093, 1621.7161996650539, 1631.5921019745065, 1650.909199994012, 1656.8674506039488, 1665.4004558359222, 817.4808996287401, 819.9631016604267, 852.26705033671, 894.5750768384966, 967.3953778888194, 15265.0, 15528.14595197275, 15919.522414327588, 15936.0, 16081.839181608268, 823.3948048184579, 824.9257566819015, 866.27233124176, 866.8916385451819, 867.5835598912431, 8931.285497160212, 9278.48968306736, 9394.107559781809, 9406.435613863054, 9418.905810941802, 318567.0, 325701.0, 353545.0, 354370.0, 355387.0, 57535.0, 58674.41325586775, 59598.0, 60551.0, 62106.0, 914.9862752058724, 924.902885197058, 927.7866090799154, 928.893177284621, 931.0689310689446, 13749.931250343685, 14006.509772157926, 14257.287135643384, 14282.285885705465, 14439.350229239919, 28861.85569072141, 29016.12951611455, 29156.854215728785, 29258.414831703674, 29915.401691966475, 36945.44581831221, 38348.6165138345, 38524.0, 38736.80631596824, 38846.80576597099, 7012.123484564429, 7017.298270173146, 7043.119610048744, 7083.610401427764, 7221.711131554679, 10080.193584513368, 10204.132648724644, 10287.94856025745, 10511.632092876713, 10698.89301106979, 8770.386072975085, 8864.0, 8883.267762786194, 8954.686585969459, 9156.496392698198, 9138.954305228697, 9140.085991400807, 9503.572339244613, 9643.469609171563, 9862.309638325249, 8750.081241469554, 9207.355485115977, 9213.12475314844, 9257.814843703223, 9375.624975000923, 6589.571677840925, 6691.364320389555, 6701.0, 6753.020811982334, 6962.617056061965, 8669.089745576624, 8790.42862213954, 8812.91187088121, 8845.0, 9233.722988310361], "unit": "score", "name": "jquery.html", "value": 7512.523799061519}, {"lowerIsBetter": false, "replicates": [1249.775040492711, 1366.1598117157948, 1391.227868532964, 1519.7112548615762, 1738.8782785205033, 6822.7612033578835, 7136.393406560449, 7140.214576396592, 7142.571445713254, 7143.357097861185, 7032.402245809112, 7211.927880721191, 7216.350528452438, 7220.602866842321, 7222.061132052839, 1777.937772177974, 1824.4435447188603, 2056.105594066586, 2149.3014770199707, 2175.9347219583437, 2096.982963262816, 2113.9154433822705, 2114.1754715660904, 2115.3230966090855, 2115.471132216946, 2047.6109539187507, 2060.577581595777, 2061.608294424062, 2115.428834214761, 2177.6080305545074, 2120.3320953899474, 2144.5925274197853, 2145.1741079684357, 2146.1415433826514, 2154.278316763878, 2103.432073340205, 2148.194427089841, 2150.516133869882, 2154.827613790893, 2157.8165855902266, 7342.632868356561, 7428.182899881009, 7430.071241094864, 7436.256374362574, 7453.962730186368, 4226.387173859804, 4345.80443880023, 4346.413234213373, 4356.912861742748, 4367.061081867382, 2758.7517123458783, 2844.1751891951308, 2868.268591509173, 2877.985610071936, 2883.1206482022976, 888.4180861535705, 919.5425201243306, 946.0444950599875, 953.4565297780268, 961.1445813226235, 10098.495075246208, 10104.393736375767, 10126.29115961883, 10133.797324053477, 10144.442055686934, 3915.5105611798526, 3993.3610622300293, 4003.339448990942, 4038.959610403917, 4052.3111071117983, 7793.298603125746, 7810.218978102144, 7890.013748281465, 7898.684052637945, 7904.249096335839, 4281.807318670667, 4291.420658211102, 4293.484781826139, 4300.032492689183, 4305.138972205571, 3330.9500357494658, 3865.497485326946, 3940.2907476653904, 3959.8416063357145, 3997.900052498711, 3233.531137984979, 3298.86804527821, 3309.1396236978076, 3314.5028245762846, 3353.5137405076125, 942.8350038743192, 968.5641461342424, 969.2488321550854, 974.5614473486959, 982.6708052802248, 1050.7373156710823, 1052.9631462898915, 1083.2579682917226, 1158.4960542164185, 1161.4483120517687, 6669.066330713704, 6681.5656982296, 6694.765683201064, 6717.664116794141, 6910.06714093601, 984.7833476635129, 994.2294721590825, 995.4624502768569, 1001.3491230699958, 1035.063267742694, 5106.234064890222, 5168.586513078944, 5195.532402083755, 5207.114790485626, 5388.838334849961, 8729.60716767747, 8921.107889211027, 8952.68665596701, 8988.10118988109, 9057.411268267542, 8022.719204827803, 8228.259456648811, 8845.115488451233, 8894.46633201997, 8900.198982091642, 6717.429018533382, 6782.491313151435, 6788.864222715617, 6798.796036118924, 6839.179298484214, 6760.526763126731, 6783.287754785676, 6840.760573379908, 6871.244163142151, 6872.484563657646, 7730.961345193238, 7756.612169391395, 7820.3743700504965, 7981.281684648409, 7997.200279971957, 8005.0, 8048.356131509582, 8355.331573473986, 8357.247847693738, 8360.456570323153, 5165.896682066413, 5759.8560035999435, 6073.574849760651, 6182.227221597301, 6187.783427580013, 6641.800745977628, 6721.193456785217, 6754.5609535380045, 6763.12079429671, 6774.96612516954, 5739.827805165852, 5791.942080579309, 5818.33089194748, 5922.082077278029, 5999.790007349722, 5636.85907852307, 5784.82645520635, 5861.0, 5936.1689363488285, 6083.969580152071, 6231.186628643954, 6252.406021427957, 6349.8730025400155, 6405.071264666504, 6414.03789431589, 6019.187409699634, 6023.096535519532, 6031.457168854824, 6051.667158306335, 6058.878822423615, 5833.416658334133, 5915.615484993462, 5946.672932988728, 5959.135925290895, 5961.493273071837], "unit": "score", "name": "mootools.html", "value": 4101.537120783762}, {"lowerIsBetter": false, "replicates": [284.7266624040921, 290.7078386221847, 291.54227862256255, 291.6893508413541, 293.44245932727813, 5221.738913054346, 5327.467253274675, 5346.4118946915805, 5366.838994830161, 5373.516383525482, 5194.71429071401, 5221.451747566508, 5221.5822734181265, 5226.608004399666, 5245.554127899133, 3827.0241088522457, 3938.0, 4036.071703508195, 4044.090079732066, 4050.0482386639264, 4012.6589239914642, 4026.0, 4033.495813023372, 4036.5963403659694, 4046.615571520701, 3785.62143785622, 3997.320455522568, 4001.7999100045026, 4004.6195611417015, 4014.3777714454304, 3926.9018274543077, 3994.520657521087, 3998.0804414984427, 4013.7190396672245, 4015.337469317559, 3472.2361080562237, 3472.722182225416, 3485.790852548855, 3490.0053484756977, 3496.3881320768764, 5015.648904576681, 5034.270030845543, 5035.899282014376, 5042.3949126104735, 5044.924326135111, 4569.109023740372, 4570.223062079454, 4572.314152877095, 4573.336866154389, 4582.495925448198, 5463.890722185534, 5465.125579907196, 5474.972625136888, 5476.069068258365, 5476.26070480484, 3810.1808111256214, 3813.370793819044, 3814.7901865397394, 3825.4261860720835, 3827.349350610403, 5518.641288316287, 5751.913721294226, 5756.625819321731, 5758.049921762904, 5764.625299355528, 3729.8321575529167, 3779.244151169777, 3801.5248093988253, 3801.847926082981, 3805.4482100095884, 3840.5007349044445, 3843.8846834595006, 3844.1735026969336, 3845.3270677631303, 3860.768353898775, 4468.843590474317, 4477.843275485342, 4484.730916145042, 4485.775711214426, 4486.573775491323, 5444.0, 5446.304079480603, 5446.373667028263, 5452.863678408072, 5458.4814442627885, 1332.613542072788, 1352.6347886070903, 1356.328617334406, 1356.5930220933878, 1357.9253141077138, 819.9221073997961, 824.8432797768405, 887.0287035695902, 897.8249241397996, 915.9267258619294, 4763.499832517536, 4787.521247875185, 4798.304245884327, 4810.302506136591, 4817.807287708452, 5592.916106258409, 5614.6631202128, 5617.297837770278, 5625.915611265835, 5634.098544232985, 4776.95223047772, 4780.593649539758, 4782.832600858953, 4783.473817880031, 4791.0, 2999.0702882106616, 3029.1518374855077, 3031.439183751013, 3032.696730326994, 3036.817790932551, 5370.3287089113865, 5376.623636345418, 5382.838514844561, 5385.434529374437, 5386.165144402624, 5602.327720673546, 5751.396103409082, 5768.134779782982, 5772.826815195467, 5785.190073389729, 5351.0, 5354.223637572608, 5361.169018802092, 5361.839144825583, 5364.892702145935, 5594.0, 5657.971710141587, 5662.66024038559, 5667.773289068556, 5675.035244008611, 5484.095124304605, 5489.505944464858, 5491.423400542885, 5492.670439773627, 5506.256655351476, 5357.330333708286, 5362.356517217959, 5362.570994320367, 5367.275417818701, 5370.979513892348, 3675.7794532328144, 3777.56557995823, 3785.129420233417, 3791.20384719201, 3798.2213646203013, 5617.101263797773, 5662.546996240373, 5666.376698563237, 5667.518260947701, 5669.943300566942, 5264.763085661078, 5367.141257398797, 5406.351237851483, 5439.48324909133, 5509.779608815603, 5499.752511137089, 5500.394956554695, 5505.064139096283, 5514.117741161395, 5517.531009864207, 5353.946460535501, 5358.276632654542, 5361.597880158925, 5364.14173732201, 5368.8389348319615, 5544.528715059265, 5549.001179787677, 5551.306086739158, 5554.694491802989, 5558.082916318762, 5268.4731526848545, 5412.458754124556, 5427.538659214011, 5429.511343979061, 5432.0765469871], "unit": "score", "name": "prototype.html", "value": 4071.736835158548}, {"lowerIsBetter": false, "replicates": [629.6505439481089, 647.543481845299, 673.7035704290115, 686.598339971117, 703.6903762344568, 10926.071283940864, 10959.12327013839, 11008.174386920973, 11024.228304018712, 11062.944685276572, 10190.74523136922, 11222.102231821455, 11283.717907052327, 11315.03822175114, 11413.201075924668, 763.0347610272995, 767.808047988003, 775.0544335910181, 776.8679324514846, 777.8211011467366, 778.1246098139593, 781.5115552779513, 782.0419985517724, 782.9217078292182, 783.7570353190529, 806.0569134113073, 807.6527093349857, 807.7092246791179, 808.6361137488125, 808.6886548678772, 803.3813963248296, 804.8309854930471, 804.9476784009021, 805.6374631415828, 806.1817255485657, 597.05068940385, 597.2116805816324, 597.4324391827738, 597.7698586044404, 598.9251343582052, 10932.617358392497, 10939.343639381583, 10990.780184396268, 10992.395418251994, 11008.944955275252, 11471.19701620887, 11760.823587646191, 12073.335966521838, 12164.452599632948, 12428.254304741655, 9643.3731807433, 9735.610575576968, 9774.364666296739, 9849.458279794608, 9927.15619172364, 3191.69678880506, 3198.344339410415, 3214.244652506659, 3214.9196270093203, 3220.6779322067605, 36460.45309320362, 36648.81675591605, 37196.81401593002, 40572.18855622871, 42423.57576424258, 9145.49699766506, 9241.630334786667, 9285.907140928639, 9313.301502387349, 9395.342326037111, 15465.304061317043, 15613.063216207063, 15616.4534241301, 15661.373545058297, 15664.608384790472, 5493.505584497414, 6490.4807615390655, 6569.244536878225, 6617.966910165418, 6692.59844409337, 3743.4384842273876, 3743.887683369503, 3782.0544863784053, 3786.3373909565717, 3889.4943657324366, 2499.387650025719, 2521.1680145551923, 2524.4698613291416, 2527.0144643589015, 2529.190658989106, 489.51782494243145, 491.5698763581866, 496.92546118081856, 503.89418222173754, 506.8530126263416, 447.77834971689225, 452.2560388161456, 483.13277666587857, 503.24764477106226, 528.2578373084596, 6870.828229294308, 6911.447084233249, 7067.84513880244, 7331.156916954618, 7352.5220860643885, 515.7436216552583, 515.9613029022838, 516.602216293452, 532.5366930770255, 536.9006733754268, 3346.330733853239, 3402.1154499829727, 3456.187795867969, 3458.8270586470576, 3482.7736197147105, 48109.27836082462, 48477.0, 48852.91632713236, 48998.75500622474, 49054.50945490571, 43326.56673433226, 43517.12965740667, 43675.56324436778, 43869.78065109654, 44089.338659920126, 34061.0, 41046.1790764183, 41819.0, 43783.78108109439, 44363.0, 7402.851942961218, 7458.0, 7469.514481558681, 7489.13874904393, 7489.812754681177, 31400.37199256048, 31725.682743173194, 31834.204144896565, 32008.0, 32122.35755284928, 35214.29571408609, 35478.645213547534, 35719.821400892826, 38232.42651360288, 39173.0, 8117.55353455542, 8478.872816907628, 9445.669401570913, 9468.621255149717, 9721.854172187564, 10626.681199564026, 10682.145428365557, 11020.173486988348, 11084.279521831055, 11262.662120136409, 9813.754656133653, 10156.339837910513, 10330.845037324296, 10482.056614904695, 10573.04842564173, 9368.016358282282, 9391.0, 10032.31558390312, 10102.191824654157, 10507.42209178472, 9468.763280918032, 9485.715428537154, 9605.807883842144, 9660.613575456902, 9971.750706232113, 8438.493690378597, 8956.731298060808, 9131.589078491352, 9141.085891411072, 9400.717978460658, 8857.335699822668, 9020.323475739215, 9174.816503670023, 9193.356465047382, 9209.861852072358], "unit": "score", "name": "yui.html", "value": 5517.047848187632}], "name": "dromaeo_css", "value": 6048.831356153382}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 114.0, 115.0, 112.0, 101.0, 114.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [166.0, 136.0, 158.0, 168.0, 133.0, 154.0, 150.0, 129.0, 167.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 163.0, 164.0, 161.0, 161.0, 163.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 99.0, 94.0, 72.0, 73.0, 76.0, 108.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.3}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 139.0, 93.0, 95.0, 94.0, 134.0, 96.0, 94.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 118.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 76.0, 65.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 67.8}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [81.0, 87.0, 84.0, 86.0, 83.0, 82.0, 84.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [119.0, 127.0, 117.0, 137.0, 127.0, 135.0, 125.0, 126.0, 127.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [146.0, 143.0, 142.0, 148.0, 156.0, 140.0, 143.0, 146.0, 151.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 70.0, 71.0, 71.0, 69.0, 70.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1537.6999999999998}]} 02:35:05 INFO - Return code: 0 02:35:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:35:05 ERROR - # TBPL SUCCESS # 02:35:05 INFO - Running post-action listener: _resource_record_post_action 02:35:05 INFO - Running post-run listener: _resource_record_post_run 02:35:06 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 525619200; Read time: 0; Write time: 1340112 02:35:06 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 233795584; Read time: 0; Write time: 901132 02:35:06 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 287887360; Read time: 0; Write time: 438576 02:35:06 INFO - Running post-run listener: _upload_blobber_files 02:35:06 INFO - Blob upload gear active. 02:35:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:35:06 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:35:06 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:35:06 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:35:07 INFO - (blobuploader) - INFO - Open directory for files ... 02:35:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:35:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:35:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:08 INFO - (blobuploader) - INFO - Done attempting. 02:35:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:35:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:35:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:09 INFO - (blobuploader) - INFO - Done attempting. 02:35:09 INFO - (blobuploader) - INFO - Iteration through files over. 02:35:09 INFO - Return code: 0 02:35:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:35:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:35:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e3744a700e92e5f4c74ff5965f39d2fa43c799f5c93e75051b1d65a1f7716c93d100c0ded9eb70014f3c71cc2a2c286e63ec1ee5c5efa1be3febeb659a4ef70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b299595f40f4fe1b82ba1b9a1dfb58ccc66bef6f76e19883409efc6270e8be2fa320779d35c7eb0650dcba0491f0d85288387a8bbbc631321a6304b18f897c6"} 02:35:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:35:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:35:09 INFO - Contents: 02:35:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e3744a700e92e5f4c74ff5965f39d2fa43c799f5c93e75051b1d65a1f7716c93d100c0ded9eb70014f3c71cc2a2c286e63ec1ee5c5efa1be3febeb659a4ef70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b299595f40f4fe1b82ba1b9a1dfb58ccc66bef6f76e19883409efc6270e8be2fa320779d35c7eb0650dcba0491f0d85288387a8bbbc631321a6304b18f897c6"} 02:35:09 INFO - Running post-run listener: copy_logs_to_upload_dir 02:35:09 INFO - Copying logs to upload dir... 02:35:09 INFO - mkdir: /builds/slave/test/build/upload/logs 02:35:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.178516 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-09 02:35:08.900050) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 02:35:08.905727) ========= 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=df17445c3590ff7897617a0e00000225-1457518469.260563-866938647 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/5e3744a700e92e5f4c74ff5965f39d2fa43c799f5c93e75051b1d65a1f7716c93d100c0ded9eb70014f3c71cc2a2c286e63ec1ee5c5efa1be3febeb659a4ef70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b299595f40f4fe1b82ba1b9a1dfb58ccc66bef6f76e19883409efc6270e8be2fa320779d35c7eb0650dcba0491f0d85288387a8bbbc631321a6304b18f897c6"} build_url:https://queue.taskcluster.net/v1/task/cpUpMppJRGazTOqfEnO9Tg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011461 build_url: 'https://queue.taskcluster.net/v1/task/cpUpMppJRGazTOqfEnO9Tg/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/5e3744a700e92e5f4c74ff5965f39d2fa43c799f5c93e75051b1d65a1f7716c93d100c0ded9eb70014f3c71cc2a2c286e63ec1ee5c5efa1be3febeb659a4ef70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b299595f40f4fe1b82ba1b9a1dfb58ccc66bef6f76e19883409efc6270e8be2fa320779d35c7eb0650dcba0491f0d85288387a8bbbc631321a6304b18f897c6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 02:35:08.932227) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 02:35:08.932611) ========= 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=df17445c3590ff7897617a0e00000225-1457518469.260563-866938647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 02:35:09.016798) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 02:35:09.017155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 02:35:09.017535) ========= ========= Total master_lag: 0.28 =========