builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1460506576.02 results: success (0) buildid: 20160412154749 builduid: d7aab3d8538e44329325ef1f3799640a revision: ea707a9243907d2e89337d01ecf7c66f5f543a86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.017984) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.018347) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.018625) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006491 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.053543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.053812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.077188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.077454) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.125659) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.125939) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.126286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.126582) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 17:16:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-04-12 17:16:16 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106598 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.245445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.245729) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022471 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.332589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.332893) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea707a9243907d2e89337d01ecf7c66f5f543a86 --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 ea707a9243907d2e89337d01ecf7c66f5f543a86 --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=934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 17:16:16,450 truncating revision to first 12 chars 2016-04-12 17:16:16,450 Setting DEBUG logging. 2016-04-12 17:16:16,450 attempt 1/10 2016-04-12 17:16:16,450 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea707a924390?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 17:16:16,705 unpacking tar archive at: fx-team-ea707a924390/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538930 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.884083) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.884396) ========= echo ea707a9243907d2e89337d01ecf7c66f5f543a86 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ea707a9243907d2e89337d01ecf7c66f5f543a86'] 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=934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ea707a9243907d2e89337d01ecf7c66f5f543a86 program finished with exit code 0 elapsedTime=0.004674 script_repo_revision: 'ea707a9243907d2e89337d01ecf7c66f5f543a86' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.934391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.934660) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 17:16:16.944771) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-12 17:16:16.945040) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:16:17 INFO - MultiFileLogger online at 20160412 17:16:17 in /builds/slave/test 17:16:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 17:16:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:16:17 INFO - {'append_to_log': False, 17:16:17 INFO - 'base_work_dir': '/builds/slave/test', 17:16:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:16:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:16:17 INFO - 'branch': 'Fx-Team-Non-PGO', 17:16:17 INFO - 'buildbot_json_path': 'buildprops.json', 17:16:17 INFO - 'config_files': ('talos/linux_config.py',), 17:16:17 INFO - 'default_actions': ('clobber', 17:16:17 INFO - 'read-buildbot-config', 17:16:17 INFO - 'download-and-extract', 17:16:17 INFO - 'populate-webroot', 17:16:17 INFO - 'create-virtualenv', 17:16:17 INFO - 'install', 17:16:17 INFO - 'run-tests'), 17:16:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:16:17 INFO - 'download_minidump_stackwalk': True, 17:16:17 INFO - 'download_symbols': 'ondemand', 17:16:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:16:17 INFO - 'tooltool.py': '/tools/tooltool.py', 17:16:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:16:17 INFO - '/tools/misc-python/virtualenv.py')}, 17:16:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:16:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:16:17 INFO - 'installer_path': 'installer.exe', 17:16:17 INFO - 'log_level': 'info', 17:16:17 INFO - 'log_name': 'talos', 17:16:17 INFO - 'log_to_console': True, 17:16:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:16:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:16:17 INFO - 'opt_config_files': (), 17:16:17 INFO - 'pip_index': False, 17:16:17 INFO - 'sps_profile': False, 17:16:17 INFO - 'sps_profile_interval': 0, 17:16:17 INFO - 'suite': 'dromaeojs-e10s', 17:16:17 INFO - 'system_bits': '32', 17:16:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:16:17 INFO - 'title': 'talos-linux64-ix-057', 17:16:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:16:17 INFO - 'use_talos_json': True, 17:16:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:16:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:16:17 INFO - 'work_dir': 'build'} 17:16:17 INFO - ##### 17:16:17 INFO - ##### Running clobber step. 17:16:17 INFO - ##### 17:16:17 INFO - Running pre-action listener: _resource_record_pre_action 17:16:17 INFO - Running main action method: clobber 17:16:17 INFO - rmtree: /builds/slave/test/build 17:16:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:16:18 INFO - Running post-action listener: _resource_record_post_action 17:16:18 INFO - ##### 17:16:18 INFO - ##### Running read-buildbot-config step. 17:16:18 INFO - ##### 17:16:18 INFO - Running pre-action listener: _resource_record_pre_action 17:16:18 INFO - Running main action method: read_buildbot_config 17:16:18 INFO - Using buildbot properties: 17:16:18 INFO - { 17:16:18 INFO - "project": "", 17:16:18 INFO - "product": "firefox", 17:16:18 INFO - "script_repo_revision": "production", 17:16:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:16:18 INFO - "repository": "", 17:16:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:16:18 INFO - "buildid": "20160412154749", 17:16:18 INFO - "pgo_build": "False", 17:16:18 INFO - "basedir": "/builds/slave/test", 17:16:18 INFO - "buildnumber": 1142, 17:16:18 INFO - "slavename": "talos-linux64-ix-057", 17:16:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:16:18 INFO - "platform": "ubuntu64_hw", 17:16:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:16:18 INFO - "branch": "fx-team", 17:16:18 INFO - "repo_path": "integration/fx-team", 17:16:18 INFO - "revision": "ea707a9243907d2e89337d01ecf7c66f5f543a86", 17:16:18 INFO - "stage_platform": "linux64", 17:16:18 INFO - "builduid": "d7aab3d8538e44329325ef1f3799640a", 17:16:18 INFO - "slavebuilddir": "test" 17:16:18 INFO - } 17:16:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:16:18 INFO - Running post-action listener: _resource_record_post_action 17:16:18 INFO - ##### 17:16:18 INFO - ##### Running download-and-extract step. 17:16:18 INFO - ##### 17:16:18 INFO - Running pre-action listener: _resource_record_pre_action 17:16:18 INFO - Running main action method: download_and_extract 17:16:18 INFO - mkdir: /builds/slave/test/build/tests 17:16:18 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')]} 17:16:18 INFO - https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/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 17:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/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 17:16:22 INFO - Downloaded 1361 bytes. 17:16:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:16:22 INFO - Using the following test package requirements: 17:16:22 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:16:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:16:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:16:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'jsshell-linux-x86_64.zip'], 17:16:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:16:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:16:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:16:22 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:16:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:16:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:16:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:22 INFO - https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:16:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:16:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:16:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/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 17:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/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 17:16:24 INFO - Downloaded 22197687 bytes. 17:16:24 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'] 17:16:24 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 17:16:25 INFO - Return code: 0 17:16:25 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 17:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:25 INFO - https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/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 17:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/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 17:16:27 INFO - Downloaded 22197687 bytes. 17:16:27 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'] 17:16:27 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 17:16:28 INFO - Return code: 0 17:16:28 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')]} 17:16:28 INFO - https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/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 17:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/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 17:16:30 INFO - Downloaded 10841076 bytes. 17:16:30 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'] 17:16:30 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 17:16:30 INFO - Return code: 0 17:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:30 INFO - https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:16:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:16:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:16:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/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 17:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP_21_cKS-SJLxZtwQC4Ng/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 17:16:31 INFO - Downloaded 54122135 bytes. 17:16:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:16:31 INFO - mkdir: /builds/slave/test/properties 17:16:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:16:31 INFO - Writing to file /builds/slave/test/properties/build_url 17:16:31 INFO - Contents: 17:16:31 INFO - build_url:https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:16:32 INFO - Running post-action listener: _resource_record_post_action 17:16:32 INFO - Running post-action listener: set_extra_try_arguments 17:16:32 INFO - ##### 17:16:32 INFO - ##### Running populate-webroot step. 17:16:32 INFO - ##### 17:16:32 INFO - Running pre-action listener: _resource_record_pre_action 17:16:32 INFO - Running main action method: populate_webroot 17:16:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:16:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:16:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:16:32 INFO - '--tppagecycles', 17:16:32 INFO - '7'], 17:16:32 INFO - 'tests': ['tsvgm']}}, 17:16:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:16:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:16:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:16:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:16:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['damp', 'tps']}, 17:16:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'tests': ['damp', 'tps']}, 17:16:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['dromaeo_dom']}, 17:16:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:16:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'other-e10s': {'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['tsvgx', 17:16:32 INFO - 'tsvgr_opacity', 17:16:32 INFO - 'tart', 17:16:32 INFO - 'tscrollx', 17:16:32 INFO - 'cart']}, 17:16:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:16:32 INFO - 'tsvgr_opacity', 17:16:32 INFO - 'tart', 17:16:32 INFO - 'tscrollx', 17:16:32 INFO - 'cart']}, 17:16:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['tp5o']}, 17:16:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'tests': ['tp5o']}, 17:16:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'talos_options': ['--disable-e10s', 17:16:32 INFO - '--xperf_path', 17:16:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:32 INFO - 'tests': ['tp5n']}, 17:16:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'talos_options': ['--xperf_path', 17:16:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:32 INFO - 'tests': ['tp5n']}}, 17:16:32 INFO - 'talos.zip': {'path': '', 17:16:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:16:32 INFO - Running post-action listener: _resource_record_post_action 17:16:32 INFO - ##### 17:16:32 INFO - ##### Running create-virtualenv step. 17:16:32 INFO - ##### 17:16:32 INFO - Running pre-action listener: _resource_record_pre_action 17:16:32 INFO - Running main action method: create_virtualenv 17:16:32 INFO - Creating virtualenv /builds/slave/test/build/venv 17:16:32 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 17:16:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:16:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:16:32 INFO - Using real prefix '/usr' 17:16:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:16:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:16:34 INFO - Installing pip.................done. 17:16:34 INFO - Return code: 0 17:16:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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')]} 17:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:34 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 0x7f8bdf3eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba640>, '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 0x28bb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', '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 17:16:34 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 17:16:34 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 17:16:34 INFO - Using env: {'DISPLAY': ':0', 17:16:34 INFO - 'HOME': '/home/cltbld', 17:16:34 INFO - 'LANG': 'en_US.UTF-8', 17:16:34 INFO - 'LANGUAGE': 'en_US:en', 17:16:34 INFO - 'LOGNAME': 'cltbld', 17:16:34 INFO - 'MAIL': '/var/mail/cltbld', 17:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:34 INFO - 'MOZ_NO_REMOTE': '1', 17:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:34 INFO - 'NO_EM_RESTART': '1', 17:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:34 INFO - 'PWD': '/builds/slave/test', 17:16:34 INFO - 'SHELL': '/bin/bash', 17:16:34 INFO - 'SHLVL': '1', 17:16:34 INFO - 'TERM': 'linux', 17:16:34 INFO - 'TMOUT': '86400', 17:16:34 INFO - 'USER': 'cltbld', 17:16:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', 17:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:34 INFO - '_': '/tools/buildbot/bin/python'} 17:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:35 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 17:16:35 INFO - Cleaning up... 17:16:35 INFO - Return code: 0 17:16:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:16:35 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')]} 17:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:35 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')]} 17:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:35 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 0x7f8bdf3eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba640>, '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 0x28bb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', '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 17:16:35 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 17:16:35 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 17:16:35 INFO - Using env: {'DISPLAY': ':0', 17:16:35 INFO - 'HOME': '/home/cltbld', 17:16:35 INFO - 'LANG': 'en_US.UTF-8', 17:16:35 INFO - 'LANGUAGE': 'en_US:en', 17:16:35 INFO - 'LOGNAME': 'cltbld', 17:16:35 INFO - 'MAIL': '/var/mail/cltbld', 17:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:35 INFO - 'MOZ_NO_REMOTE': '1', 17:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:35 INFO - 'NO_EM_RESTART': '1', 17:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:35 INFO - 'PWD': '/builds/slave/test', 17:16:35 INFO - 'SHELL': '/bin/bash', 17:16:35 INFO - 'SHLVL': '1', 17:16:35 INFO - 'TERM': 'linux', 17:16:35 INFO - 'TMOUT': '86400', 17:16:35 INFO - 'USER': 'cltbld', 17:16:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', 17:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:35 INFO - '_': '/tools/buildbot/bin/python'} 17:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:35 INFO - Downloading/unpacking psutil>=0.7.1 17:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:16:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:37 INFO - Installing collected packages: psutil 17:16:37 INFO - Running setup.py install for psutil 17:16:37 INFO - building 'psutil._psutil_linux' extension 17:16:37 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 17:16:37 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 17:16:37 INFO - building 'psutil._psutil_posix' extension 17:16:37 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 17:16:37 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 17:16:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:37 INFO - Successfully installed psutil 17:16:37 INFO - Cleaning up... 17:16:37 INFO - Return code: 0 17:16:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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')]} 17:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8bdf3eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba640>, '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 0x28bb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', '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 17:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:16:37 INFO - Using env: {'DISPLAY': ':0', 17:16:37 INFO - 'HOME': '/home/cltbld', 17:16:37 INFO - 'LANG': 'en_US.UTF-8', 17:16:37 INFO - 'LANGUAGE': 'en_US:en', 17:16:37 INFO - 'LOGNAME': 'cltbld', 17:16:37 INFO - 'MAIL': '/var/mail/cltbld', 17:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:37 INFO - 'MOZ_NO_REMOTE': '1', 17:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:37 INFO - 'NO_EM_RESTART': '1', 17:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:37 INFO - 'PWD': '/builds/slave/test', 17:16:37 INFO - 'SHELL': '/bin/bash', 17:16:37 INFO - 'SHLVL': '1', 17:16:37 INFO - 'TERM': 'linux', 17:16:37 INFO - 'TMOUT': '86400', 17:16:37 INFO - 'USER': 'cltbld', 17:16:37 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', 17:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:37 INFO - '_': '/tools/buildbot/bin/python'} 17:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:16:38 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 17:16:38 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 17:16:38 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 17:16:38 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 17:16:38 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 17:16:38 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 17:16:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:16:39 INFO - Installing collected packages: mozsystemmonitor 17:16:39 INFO - Running setup.py install for mozsystemmonitor 17:16:40 INFO - Successfully installed mozsystemmonitor 17:16:40 INFO - Cleaning up... 17:16:40 INFO - Return code: 0 17:16:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8bdf3eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba640>, '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 0x28bb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', '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 17:16:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:16:40 INFO - Using env: {'DISPLAY': ':0', 17:16:40 INFO - 'HOME': '/home/cltbld', 17:16:40 INFO - 'LANG': 'en_US.UTF-8', 17:16:40 INFO - 'LANGUAGE': 'en_US:en', 17:16:40 INFO - 'LOGNAME': 'cltbld', 17:16:40 INFO - 'MAIL': '/var/mail/cltbld', 17:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:40 INFO - 'MOZ_NO_REMOTE': '1', 17:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:40 INFO - 'NO_EM_RESTART': '1', 17:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:40 INFO - 'PWD': '/builds/slave/test', 17:16:40 INFO - 'SHELL': '/bin/bash', 17:16:40 INFO - 'SHLVL': '1', 17:16:40 INFO - 'TERM': 'linux', 17:16:40 INFO - 'TMOUT': '86400', 17:16:40 INFO - 'USER': 'cltbld', 17:16:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', 17:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:40 INFO - '_': '/tools/buildbot/bin/python'} 17:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:40 INFO - Downloading/unpacking blobuploader==1.2.4 17:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - Downloading blobuploader-1.2.4.tar.gz 17:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:16:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:16:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - Downloading docopt-0.6.1.tar.gz 17:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:16:42 INFO - Installing collected packages: blobuploader, requests, docopt 17:16:42 INFO - Running setup.py install for blobuploader 17:16:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:16:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:16:43 INFO - Running setup.py install for requests 17:16:43 INFO - Running setup.py install for docopt 17:16:43 INFO - Successfully installed blobuploader requests docopt 17:16:43 INFO - Cleaning up... 17:16:43 INFO - Return code: 0 17:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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')]} 17:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:43 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 0x7f8bdf3eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba640>, '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 0x28bb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', '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 17:16:43 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 17:16:43 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 17:16:43 INFO - Using env: {'DISPLAY': ':0', 17:16:43 INFO - 'HOME': '/home/cltbld', 17:16:43 INFO - 'LANG': 'en_US.UTF-8', 17:16:43 INFO - 'LANGUAGE': 'en_US:en', 17:16:43 INFO - 'LOGNAME': 'cltbld', 17:16:43 INFO - 'MAIL': '/var/mail/cltbld', 17:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:43 INFO - 'MOZ_NO_REMOTE': '1', 17:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:43 INFO - 'NO_EM_RESTART': '1', 17:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:43 INFO - 'PWD': '/builds/slave/test', 17:16:43 INFO - 'SHELL': '/bin/bash', 17:16:43 INFO - 'SHLVL': '1', 17:16:43 INFO - 'TERM': 'linux', 17:16:43 INFO - 'TMOUT': '86400', 17:16:43 INFO - 'USER': 'cltbld', 17:16:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', 17:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:43 INFO - '_': '/tools/buildbot/bin/python'} 17:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:43 INFO - Running setup.py (path:/tmp/pip-RZV6vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:43 INFO - Running setup.py (path:/tmp/pip-XGU7sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:43 INFO - Running setup.py (path:/tmp/pip-bAKdO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:43 INFO - Running setup.py (path:/tmp/pip-UrJYsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:44 INFO - Running setup.py (path:/tmp/pip-IXdi_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:44 INFO - Running setup.py (path:/tmp/pip-yfT0bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:44 INFO - Running setup.py (path:/tmp/pip-FCvu9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:44 INFO - Running setup.py (path:/tmp/pip-bw4Nud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:44 INFO - Running setup.py (path:/tmp/pip-hwM265-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:44 INFO - Running setup.py (path:/tmp/pip-bSNERu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:44 INFO - Running setup.py (path:/tmp/pip-7kqZik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:44 INFO - Running setup.py (path:/tmp/pip-dUmr4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:44 INFO - Running setup.py (path:/tmp/pip-dviVQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:44 INFO - Running setup.py (path:/tmp/pip-o_ZMRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:44 INFO - Running setup.py (path:/tmp/pip-yWQxdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:44 INFO - Running setup.py (path:/tmp/pip-6CAfIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:44 INFO - Running setup.py (path:/tmp/pip-pX4zQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:16:44 INFO - Running setup.py install for manifestparser 17:16:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Running setup.py install for mozcrash 17:16:45 INFO - Running setup.py install for mozdebug 17:16:45 INFO - Running setup.py install for mozdevice 17:16:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Running setup.py install for mozfile 17:16:45 INFO - Running setup.py install for mozhttpd 17:16:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Running setup.py install for mozinfo 17:16:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Running setup.py install for mozInstall 17:16:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Running setup.py install for mozleak 17:16:45 INFO - Running setup.py install for mozlog 17:16:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Running setup.py install for moznetwork 17:16:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Running setup.py install for mozprocess 17:16:46 INFO - Running setup.py install for mozprofile 17:16:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Running setup.py install for mozrunner 17:16:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Running setup.py install for mozscreenshot 17:16:46 INFO - Running setup.py install for moztest 17:16:46 INFO - Running setup.py install for mozversion 17:16:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:16:46 INFO - Cleaning up... 17:16:46 INFO - Return code: 0 17:16:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:46 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')]} 17:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:46 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')]} 17:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:46 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 0x7f8bdf3eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba640>, '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 0x28bb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', '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 17:16:46 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 17:16:46 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 17:16:46 INFO - Using env: {'DISPLAY': ':0', 17:16:46 INFO - 'HOME': '/home/cltbld', 17:16:46 INFO - 'LANG': 'en_US.UTF-8', 17:16:46 INFO - 'LANGUAGE': 'en_US:en', 17:16:46 INFO - 'LOGNAME': 'cltbld', 17:16:46 INFO - 'MAIL': '/var/mail/cltbld', 17:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:46 INFO - 'MOZ_NO_REMOTE': '1', 17:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:46 INFO - 'NO_EM_RESTART': '1', 17:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:46 INFO - 'PWD': '/builds/slave/test', 17:16:46 INFO - 'SHELL': '/bin/bash', 17:16:46 INFO - 'SHLVL': '1', 17:16:46 INFO - 'TERM': 'linux', 17:16:46 INFO - 'TMOUT': '86400', 17:16:46 INFO - 'USER': 'cltbld', 17:16:46 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', 17:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:46 INFO - '_': '/tools/buildbot/bin/python'} 17:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:46 INFO - Running setup.py (path:/tmp/pip-ycy483-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:47 INFO - Running setup.py (path:/tmp/pip-ARq_40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:47 INFO - Running setup.py (path:/tmp/pip-OUfIUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:47 INFO - Running setup.py (path:/tmp/pip-VDMyW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:47 INFO - Running setup.py (path:/tmp/pip-rn5x95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:47 INFO - Running setup.py (path:/tmp/pip-_2MKyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:47 INFO - Running setup.py (path:/tmp/pip-flcQzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:47 INFO - Running setup.py (path:/tmp/pip-UftbV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:47 INFO - Running setup.py (path:/tmp/pip-4N5iX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:47 INFO - Running setup.py (path:/tmp/pip-GmB95I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:47 INFO - Running setup.py (path:/tmp/pip-uceuDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:47 INFO - Running setup.py (path:/tmp/pip-m03hW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:47 INFO - Running setup.py (path:/tmp/pip-6Q3YLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:47 INFO - Running setup.py (path:/tmp/pip-OudCaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:47 INFO - Running setup.py (path:/tmp/pip-cFeKHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:48 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)) 17:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:48 INFO - Running setup.py (path:/tmp/pip-JcKlyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:48 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)) 17:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:48 INFO - Running setup.py (path:/tmp/pip-Z1cKvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:48 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)) 17:16:48 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)) 17:16:48 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)) 17:16:48 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)) 17:16:48 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)) 17:16:48 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)) 17:16:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16: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 17:16: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 17:16: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 17:16: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 17:16: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 17:16: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 17:16:50 INFO - Downloading blessings-1.6.tar.gz 17:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:16:50 INFO - Installing collected packages: blessings 17:16:50 INFO - Running setup.py install for blessings 17:16:50 INFO - Successfully installed blessings 17:16:50 INFO - Cleaning up... 17:16:50 INFO - Return code: 0 17:16:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:16:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:50 INFO - Reading from file tmpfile_stdout 17:16:50 INFO - Current package versions: 17:16:50 INFO - argparse == 1.2.1 17:16:50 INFO - blessings == 1.6 17:16:50 INFO - blobuploader == 1.2.4 17:16:50 INFO - docopt == 0.6.1 17:16:50 INFO - manifestparser == 1.1 17:16:50 INFO - mozInstall == 1.12 17:16:50 INFO - mozcrash == 0.17 17:16:50 INFO - mozdebug == 0.1 17:16:50 INFO - mozdevice == 0.48 17:16:50 INFO - mozfile == 1.2 17:16:50 INFO - mozhttpd == 0.7 17:16:50 INFO - mozinfo == 0.9 17:16:50 INFO - mozleak == 0.1 17:16:50 INFO - mozlog == 3.1 17:16:50 INFO - moznetwork == 0.27 17:16:50 INFO - mozprocess == 0.22 17:16:50 INFO - mozprofile == 0.28 17:16:50 INFO - mozrunner == 6.11 17:16:50 INFO - mozscreenshot == 0.1 17:16:50 INFO - mozsystemmonitor == 0.0 17:16:50 INFO - moztest == 0.7 17:16:50 INFO - mozversion == 1.4 17:16:50 INFO - psutil == 3.1.1 17:16:50 INFO - requests == 1.2.3 17:16:50 INFO - wsgiref == 0.1.2 17:16:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:50 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 0x7f8bdf3eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba640>, '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 0x28bb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', '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 17:16:50 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 17:16:50 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 17:16:50 INFO - Using env: {'DISPLAY': ':0', 17:16:50 INFO - 'HOME': '/home/cltbld', 17:16:50 INFO - 'LANG': 'en_US.UTF-8', 17:16:50 INFO - 'LANGUAGE': 'en_US:en', 17:16:50 INFO - 'LOGNAME': 'cltbld', 17:16:50 INFO - 'MAIL': '/var/mail/cltbld', 17:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:50 INFO - 'MOZ_NO_REMOTE': '1', 17:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:50 INFO - 'NO_EM_RESTART': '1', 17:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:50 INFO - 'PWD': '/builds/slave/test', 17:16:50 INFO - 'SHELL': '/bin/bash', 17:16:50 INFO - 'SHLVL': '1', 17:16:50 INFO - 'TERM': 'linux', 17:16:50 INFO - 'TMOUT': '86400', 17:16:50 INFO - 'USER': 'cltbld', 17:16:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', 17:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:50 INFO - '_': '/tools/buildbot/bin/python'} 17:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 INFO - Cleaning up... 17:16:50 INFO - Return code: 0 17:16:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:50 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 0x7f8bdf3eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba640>, '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 0x28bb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', '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 17:16:50 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 17:16:50 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 17:16:50 INFO - Using env: {'DISPLAY': ':0', 17:16:50 INFO - 'HOME': '/home/cltbld', 17:16:50 INFO - 'LANG': 'en_US.UTF-8', 17:16:50 INFO - 'LANGUAGE': 'en_US:en', 17:16:50 INFO - 'LOGNAME': 'cltbld', 17:16:50 INFO - 'MAIL': '/var/mail/cltbld', 17:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:50 INFO - 'MOZ_NO_REMOTE': '1', 17:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:50 INFO - 'NO_EM_RESTART': '1', 17:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:50 INFO - 'PWD': '/builds/slave/test', 17:16:50 INFO - 'SHELL': '/bin/bash', 17:16:50 INFO - 'SHLVL': '1', 17:16:50 INFO - 'TERM': 'linux', 17:16:50 INFO - 'TMOUT': '86400', 17:16:50 INFO - 'USER': 'cltbld', 17:16:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', 17:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:50 INFO - '_': '/tools/buildbot/bin/python'} 17:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:50 INFO - Downloading/unpacking jsonschema 17:16: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 17:16: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 17:16: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 17:16: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 17:16: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 17:16: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 17:16:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:16:52 INFO - Downloading/unpacking functools32 (from jsonschema) 17:16:52 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 17:16:52 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 17:16:52 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 17:16:52 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 17:16:52 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 17:16:52 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 17:16:52 INFO - Downloading functools32-3.2.3-2.tar.gz 17:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:16:53 INFO - warning: no files found matching '*.txt' 17:16:53 INFO - no previously-included directories found matching 'build' 17:16:53 INFO - no previously-included directories found matching 'dist' 17:16:53 INFO - no previously-included directories found matching '.git*' 17:16:53 INFO - Installing collected packages: jsonschema, functools32 17:16:53 INFO - Running setup.py install for functools32 17:16:53 INFO - warning: no files found matching '*.txt' 17:16:53 INFO - no previously-included directories found matching 'build' 17:16:53 INFO - no previously-included directories found matching 'dist' 17:16:53 INFO - no previously-included directories found matching '.git*' 17:16:53 INFO - Successfully installed jsonschema functools32 17:16:53 INFO - Cleaning up... 17:16:53 INFO - Return code: 0 17:16:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdf3eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba640>, '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 0x28bb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', '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 17:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:16:53 INFO - Using env: {'DISPLAY': ':0', 17:16:53 INFO - 'HOME': '/home/cltbld', 17:16:53 INFO - 'LANG': 'en_US.UTF-8', 17:16:53 INFO - 'LANGUAGE': 'en_US:en', 17:16:53 INFO - 'LOGNAME': 'cltbld', 17:16:53 INFO - 'MAIL': '/var/mail/cltbld', 17:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:53 INFO - 'MOZ_NO_REMOTE': '1', 17:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:53 INFO - 'NO_EM_RESTART': '1', 17:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:53 INFO - 'PWD': '/builds/slave/test', 17:16:53 INFO - 'SHELL': '/bin/bash', 17:16:53 INFO - 'SHLVL': '1', 17:16:53 INFO - 'TERM': 'linux', 17:16:53 INFO - 'TMOUT': '86400', 17:16:53 INFO - 'USER': 'cltbld', 17:16:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', 17:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:53 INFO - '_': '/tools/buildbot/bin/python'} 17:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:53 INFO - Downloading/unpacking flake8 17:16:53 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 17:16:53 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 17:16:53 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 17:16:53 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 17:16:53 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 17:16:53 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 17:16:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:16:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:16:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:16:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:56 INFO - no previously-included directories found matching 'docs/_build' 17:16:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:16:56 INFO - Running setup.py install for pep8 17:16:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:56 INFO - no previously-included directories found matching 'docs/_build' 17:16:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:16:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:16:56 INFO - Cleaning up... 17:16:56 INFO - Return code: 0 17:16:56 INFO - Running post-action listener: _resource_record_post_action 17:16:56 INFO - Running post-action listener: _start_resource_monitoring 17:16:56 INFO - Starting resource monitoring. 17:16:56 INFO - ##### 17:16:56 INFO - ##### Running install step. 17:16:56 INFO - ##### 17:16:56 INFO - Running pre-action listener: _resource_record_pre_action 17:16:56 INFO - Running main action method: install 17:16:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:56 INFO - Reading from file tmpfile_stdout 17:16:56 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:56 INFO - Reading from file tmpfile_stdout 17:16:56 INFO - Output received: 17:16:56 INFO - Usage: mozinstall [options] installer 17:16:56 INFO - Options: 17:16:56 INFO - -h, --help show this help message and exit 17:16:56 INFO - -d DEST, --destination=DEST 17:16:56 INFO - Directory to install application into. [default: 17:16:56 INFO - "/builds/slave/test"] 17:16:56 INFO - --app=APP Application being installed. [default: firefox] 17:16:56 INFO - mkdir: /builds/slave/test/build/application 17:16:56 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'] 17:16:56 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 17:17:12 INFO - Reading from file tmpfile_stdout 17:17:12 INFO - Output received: 17:17:12 INFO - /builds/slave/test/build/application/firefox/firefox 17:17:12 INFO - Running post-action listener: _resource_record_post_action 17:17:12 INFO - ##### 17:17:12 INFO - ##### Running run-tests step. 17:17:12 INFO - ##### 17:17:12 INFO - Running pre-action listener: _resource_record_pre_action 17:17:12 INFO - Running main action method: run_tests 17:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:17:12 INFO - Python 2.7.3 17:17:12 INFO - Return code: 0 17:17:12 INFO - grabbing minidump binary from tooltool 17:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:12 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 0x28ba640>, '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 0x28bb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bb9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:17:12 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 17:17:12 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 17:17:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:17:12 INFO - Return code: 0 17:17:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:17:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:17:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:17:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:17:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:17:13 INFO - Return code: 0 17:17:13 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:17:13 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:17:13 INFO - Using env: {'DISPLAY': ':0', 17:17:13 INFO - 'HOME': '/home/cltbld', 17:17:13 INFO - 'LANG': 'en_US.UTF-8', 17:17:13 INFO - 'LANGUAGE': 'en_US:en', 17:17:13 INFO - 'LOGNAME': 'cltbld', 17:17:13 INFO - 'MAIL': '/var/mail/cltbld', 17:17:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:17:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:13 INFO - 'MOZ_NO_REMOTE': '1', 17:17:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:13 INFO - 'NO_EM_RESTART': '1', 17:17:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:13 INFO - 'PWD': '/builds/slave/test', 17:17:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:17:13 INFO - 'SHELL': '/bin/bash', 17:17:13 INFO - 'SHLVL': '1', 17:17:13 INFO - 'TERM': 'linux', 17:17:13 INFO - 'TMOUT': '86400', 17:17:13 INFO - 'USER': 'cltbld', 17:17:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842', 17:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:13 INFO - '_': '/tools/buildbot/bin/python'} 17:17:13 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:17:13 INFO - mozversion application_buildid: 20160412154749 17:17:13 INFO - mozversion application_changeset: ea707a9243907d2e89337d01ecf7c66f5f543a86 17:17:13 INFO - mozversion application_display_name: Nightly 17:17:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:17:13 INFO - mozversion application_name: Firefox 17:17:13 INFO - mozversion application_remotingname: firefox 17:17:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:17:13 INFO - mozversion application_vendor: Mozilla 17:17:13 INFO - mozversion application_version: 48.0a1 17:17:13 INFO - mozversion platform_buildid: 20160412154749 17:17:13 INFO - mozversion platform_changeset: ea707a9243907d2e89337d01ecf7c66f5f543a86 17:17:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:17:13 INFO - mozversion platform_version: 48.0a1 17:17:13 INFO - using testdate: 1460506633 17:17:13 INFO - actual date: 1460506633 17:17:13 INFO - starting webserver on 'localhost:34672' 17:17:13 INFO - SUITE-START | Running 2 tests 17:17:13 INFO - TEST-START | dromaeo_css 17:17:13 INFO - operating with platform_type : linux_ 17:17:13 INFO - Initialising browser for dromaeo_css test... 17:17:13 INFO - TEST-INFO | started process 10843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJoW1Bg/profile http://localhost:34672/getInfo.html) 17:17:17 INFO - PROCESS | 10843 | 17:17:17 INFO - PROCESS | 10843 | (process:10911): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:17:17 INFO - PROCESS | 10843 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:17:18 INFO - PROCESS | 10843 | __metrics Screen width/height:1600/1200 17:17:18 INFO - PROCESS | 10843 | colorDepth:24 17:17:18 INFO - PROCESS | 10843 | Browser inner width/height: 1024/697 17:17:18 INFO - PROCESS | 10843 | __metrics 17:17:19 ERROR - PROCESS | 10843 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:17:20 INFO - TEST-INFO | 10843: exit 0 17:17:20 INFO - Browser initialized. 17:17:20 INFO - Running cycle 1/1 for dromaeo_css test... 17:17:20 INFO - TEST-INFO | started process 10962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJoW1Bg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:22 INFO - PROCESS | 10962 | 17:17:22 INFO - PROCESS | 10962 | (process:11020): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:17:32 INFO - PROCESS | 10962 | RSS: Main: 164712448 17:17:32 INFO - PROCESS | 10962 | 17:18:21 INFO - PROCESS | 10962 | 1460506701754 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] 17:20:33 INFO - PROCESS | 10962 | Cycle 1(1): loaded http://localhost:34672/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34672/tests/dromaeo/cssquery-ext.html) 17:20:34 INFO - PROCESS | 10962 | RSS: Main: 169250816 17:20:34 INFO - PROCESS | 10962 | 17:23:36 INFO - PROCESS | 10962 | Cycle 1(1): loaded http://localhost:34672/tests/dromaeo/cssquery-ext.html (next: http://localhost:34672/tests/dromaeo/cssquery-jquery.html) 17:23:37 INFO - PROCESS | 10962 | RSS: Main: 165535744 17:23:37 INFO - PROCESS | 10962 | 17:26:39 INFO - PROCESS | 10962 | Cycle 1(1): loaded http://localhost:34672/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34672/tests/dromaeo/cssquery-mootools.html) 17:26:39 INFO - PROCESS | 10962 | RSS: Main: 166916096 17:26:39 INFO - PROCESS | 10962 | 17:29:41 INFO - PROCESS | 10962 | Cycle 1(1): loaded http://localhost:34672/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34672/tests/dromaeo/cssquery-prototype.html) 17:29:42 INFO - PROCESS | 10962 | RSS: Main: 164241408 17:29:42 INFO - PROCESS | 10962 | 17:32:44 INFO - PROCESS | 10962 | Cycle 1(1): loaded http://localhost:34672/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34672/tests/dromaeo/cssquery-yui.html) 17:32:45 INFO - PROCESS | 10962 | RSS: Main: 165347328 17:32:45 INFO - PROCESS | 10962 | 17:35:48 INFO - PROCESS | 10962 | Cycle 1(1): loaded http://localhost:34672/tests/dromaeo/cssquery-yui.html (next: http://localhost:34672/tests/dromaeo/cssquery-dojo.html) 17:35:48 INFO - PROCESS | 10962 | RSS: Main: 167485440 17:35:48 INFO - PROCESS | 10962 | 17:35:48 INFO - PROCESS | 10962 | __start_tp_report 17:35:48 INFO - PROCESS | 10962 | _x_x_mozilla_page_load 17:35:48 INFO - PROCESS | 10962 | _x_x_mozilla_page_load_details 17:35:48 INFO - PROCESS | 10962 | |i|pagename|runs| 17:35:48 INFO - PROCESS | 10962 | |0;dojo.html;2608.478304339132;2661.866906654667;2720.279126031603;2722.3330284080403;2740.4930087933735;4765.642576806736;4765.714057156569;4786.712797232164;4788.399259484737;4847.418309802829;4645.279981602857;4782;4827.468978412372;4855.126077306083;4865.708057516552;4369.93445098323;4409.206342858284;4437.689361744679;4489.910201795962;4508.909821803562;4433.935855394714;4440.666949978765;4491.4610246770435;4510.097980403916;4538.205813982557;4267.914641707149;4365.563443655641;4390.100029493946;4441.244988351988;4462.308342206963;4367.344898265285;4377.387165796791;4387.0129220925355;4396.296592545209;4421.955780442187;4353.760543170124;4379.934300985487;4383.82806027017;4385.429894113777;4405.471343438808;4490.146872094291;4563.794629241692;4634.95365046352;4647.88380290492;4668.976655116703;5114.386273647149;5134.666246693953;5157.458466860963;5157.896842063138;5211.921821172686;5170.146925757245;5174.689518628894;5177.404598471187;5179.741012949337;5186.844394668166;4678.672492925497;4774.379330687023;4800.975995120072;4829.95170048302;4855.150348688965;5262.210668399694;5306.8407947761625;5314;5323.0684630190335;5352.2506849041165;4921.311016457699;5077.060743762416;5078.619103567247;5080.822171224063;5081;4984.27727979441;5159.509846564571;5196.194589838581;5216.58267338612;5251.238570407346;5002.09962206799;5021.949780502221;5032.295478632995;5037.3955125384455;5088.796448142107;5114.744262786846;5118.564921981599;5128.974355128201;5130.87172820675;5177.378714554277;4292.849750258726;4369.978150109293;4374.059577190919;4398.494173170063;4410.007748256617;3740.6259374062374;3740.8877733668032;3747.512823332949;3771.2080463103057;3790.090378309186;4353.085851971058;4370.191514569815;4380.978095109568;4400.581944715247;4431.224535706238;5049.2426136079885;5061.974690126526;5102.285680004802;5135.6148288878485;5148.047611191867;4346.391505189276;4355.216061109031;4387.670924680598;4393.7363758174615;4429.402030725811;4520.796564154621;4554.658400619966;4580.564846339593;4660.720356778605;4719.268513380432;4809.615230781459;4816.590589799906;4830.2513110467935;4865.7323847188745;4897.681650692693;5146.176611742103;5150.536451719363;5154.922676159786;5157.613179011514;5180.248863914787;4636.235021221461;4800.279958006327;4812.807487700453;4882.95117048825;4909.77905994224;5075.2387141929;5091.490850914879;5097.464766199496;5107.540321371094;5145.691258524501;5153.433122356463;5167.974160129175;5173;5181.585473162213;5183.222516622537;4845.5881250094135;4917.5328343808715;4968.056069346812;4980.701157930535;5000.849974500771;4813.95186048149;4900.779464924016;4905.9018819624125;4911.68074075184;4914.950850491592;4751.572358487752;4793.209120495079;4868.513148685245;4875.488073752205;4928.310036594951;4984.675996060245;4992.475790042138;4996.825111121093;4998.525140111829;5047.1419858623385;4785.880352991064;4790.377250957354;4847.515248475124;4889.682170658896;4931.3835770528685 17:35:48 INFO - PROCESS | 10962 | |1;ext.html;570.5692202387197;608.9025755879057;613.3804857094335;628.4312697009208;633.7053270229344;34590.82704586477;35611.2877742445;35916.64083359166;35925.64074359256;36022.63977360232;36118.819405903;36641.81679091608;36663.633363666355;36737;36840.81579592105;7569.810754731121;7683.538987660758;7704.845903081935;7722.652480638385;7724.266194711493;7522.887156692654;7741.071071471431;7757.107932587768;7775.105862825762;7792.961035194816;7723.111842138142;7773.611319434006;7787.610619469032;7792.415568832332;7799.064112306532;7697.576633285167;7776.844463110762;7778.183290754502;7791.181925897756;7810.921890781076;7739.6904123834975;7760.456768026241;7775.611219439062;7838.804029899241;7843.058832940027;30209.244768880733;36981.81509092464;37151.62848371509;37329.81335093334;37480.81259593685;2802.6776920654183;2886.1774394297527;2948.189247956808;3163.57291765611;3163.7152656261046;23812;24306.513869722505;24367.390815229584;24509.754902450924;24744.876275618688;3064.1114076917665;3114.112477943798;3125.562421261025;3194.073718621597;3257.0228931320507;144629;145010;145453;145611.27194364066;145703.27148364295;31037.224069397995;31085.378292434478;31096.689033109833;31280.843595781877;31503.684963150532;32083;32214.516782248284;60746.392536074956;62785.68607156935;62820.68589657023;12235.694107647201;12434.875651243552;12451.128421010624;12464.252144871336;12504.3747812609;9094.81810363789;9095.772605684779;9108.225800806873;9117.908820911705;9138.68014619485;18391.54021149482;18393.172307246205;18458.63082738338;18592.163352649164;18650.34723784661;7051.1891132519395;7074.92925070753;7234.493585448968;7320.194778574352;7433.665485053186;894.7494701483595;990.1237404896574;1000.2048371544639;1026.5175367577226;1064.031731124673;26655.466890662465;27196.864015679796;27201.72798271992;27202.45595088087;27315.31711707223;1024.6925922223304;1026.5688410867454;1057.7197042783669;1068.4550879051585;1086.9402182880017;14215.715685686228;14744.262786860614;14875.70248595022;15079.54761357161;15092.698146037017;156201;156595.21702391416;157316;157650;158592;46982.5301746985;48035;48225.27662085072;48228.5177148224;48262.51737482651;1241.2428418664608;1262.7537630162215;1268.5243033862303;1271.8728127187392;1271.8918891894107;26601.733982659927;27193.45613087767;27738.167854964384;28082.438351233268;28182;41169.38245926254;41859;42009.78995105005;42310.78844605757;42358;281806;284341;285083;285089;286144;24800.875995619906;25416.110436134648;25562.616560751976;25582.616260756477;25676.486470270862;40958.79520602378;41174.38238426366;41903;42004.78997604993;42022.78988605038;35107;35770.10574735548;35781.64218357887;36026.27947441089;37062.814685926394;34295.142621434665;35199.29601407906;35528.111797205274;35574.46638300376;35726;35491.467627986116;35692.64307356997;36090;37626.2474750498;37720.811395942845;27430.725692742817;30697.846510767304;30767.2308192297;31050.378992420476;31176;22835.657465138367;23802.761972380056;23942.880285599156;24156.275311740676;24293.514129716954 17:35:48 INFO - PROCESS | 10962 | |2;jquery.html;366.6645019806877;370.6552905797608;378.7027183660827;380.40656575741826;389.9376099824029;15789.526314210578;16044.438444654439;16826.411075612355;16837.83162168378;16866.66266674666;16049.919750401232;16596.66806663866;17305.480835574952;17401.477955661318;17473.912630436862;5120;5303.045451818671;5317.867053323659;5331.813386531472;5336.226247194155;3650.7992060436663;5177;5606.55147588194;5856.824295271149;5945.256842894638;5836.5038971687245;5839.182514447981;5841.357450680422;5842.357340692521;5847.356790753014;5719.542436605082;6000.789972350991;6008.309044459856;6009.4591486766185;6013.278406591237;4454.688171827974;5158.716270605115;5164.147915593922;5241.082810508184;5248.895022099537;18482.81517184838;18595.44213673592;18961.715574266396;19114.044297785193;19156.946367949757;1785.098525244756;1815.1015247452463;1906.761654793151;1921.0586812461793;1929.2861641192708;8243.340532757366;9020.097990200993;9026.638934442615;13195.802062969064;13645.522406715718;1793.3095758133081;1818.1545581304624;1871.1112221694723;1872.616113696689;1922.9615407691908;61811.07283390708;61899;73835.26164738338;77175.22824771737;81497.9999999994;15977.920110399606;16286.755698664529;16499.6700065998;16549.089800060872;16609.169541522875;29595.704042959296;29706.554401683992;29922.850385748367;29937.401251975276;29989;7924.683012679428;8138.3082437993435;8200.507969521848;8329.541875196923;8346.081930987586;6504.15445992018;6590.439812615981;6608.3391660834495;6616.239132499728;6687.866242675119;8072.636731346986;8145.71489997859;8289.129641387688;8328.500289982621;8388.37087218461;1663.517579901815;1851.6024441950367;1858.4053103006909;1877.8873267603988;3382.2051817822794;846.5344060766554;853.4665833853842;862.8748831419409;866.8049688819965;907.0521305235912;15231.619209519851;15384.692306153815;15432.15123168214;15747.212639368216;15755.921220394053;849.6643825688818;870.4429165334191;871.5859966515981;905.981880362389;909.8589718593629;9156.542172891328;9201.861972070425;9246.815063698823;9264.44413335202;9438.716838494856;307028;316019;392420;410841;410945;66752.33247667461;73751;75313;75973;78578;990.5740531571494;990.7671697151163;1000.9699709008596;1040.2198351236573;1053.578568572577;15144.54566363011;15267.923660381626;15368.001079929769;15457.149856757986;15893.761593575875;33096.66903330936;33299.667003329654;33705.49441758425;34237.48643770296;34292.82853585716;46665.53334466748;47967;48641;48813.26780098231;48996.75501622469;7620.5808680523105;7686.6541005656;7711.691532338644;7806.102298235548;7916;10606.787864242826;10691.8930810694;11405.20163588574;11516.654500365003;11764.411779411166;10189.74525636865;10234.385936843813;10366;10401.84397234027;10670.679879603624;8817.294616430798;9737.415755054719;9999.250056245664;10123.291369604058;10345.63790267337;10347.482625868826;10497.737556561147;10541.31481453703;10583.576656933636;10620.256582039183;7497.250274972677;7542.811429714082;7698.191689872707;7701.499402538817;8015.879761803461;9627.56675949598;10342.32774869631;10401.635942741968;10402.27184097106;10713.35719856811 17:35:48 INFO - PROCESS | 10962 | |3;mootools.html;1271.9745605087899;1369.6644322141076;1371.814805001325;1793.5247159502742;1829.067175740373;6951.652417379136;7574.659140338684;7698;7843.411744119193;7854.882176767346;7709.807254818632;7791.961040194791;7828.921710782891;7853.528788272708;7865.842683146334;2278.7265528136604;2305.13557415969;2315.490592069742;2324.418895276181;2324.976750232501;2197.6923230747707;2227.7438094619083;2256.7968882800546;2271.432141964509;2272.1820144747876;2202.383332666856;2213.734351877777;2239.496113374494;2256.6050941085327;2266.6826644269813;2232.698585690943;2271.3867255840914;2281.999999999992;2282.47503074293;2289.347535952246;2207.9668804967937;2209.1494774511766;2220.4781876259226;2221.9555608887895;2224.4994876152896;7767.6892924282965;7863.488873223222;7894.447388682795;7897.6840926362875;7913.683452661887;4295.570442955711;4414.426124603813;4431.091626216617;4442.977785111086;4467.262901621229;2920.32832448538;2944.6024786653743;3075.5079187330143;3088.1044497095813;3118.937621247585;958.3195930889077;973.2797729679986;998.5855869814019;1008.8284991551454;1026.8870424253325;10200.489975501196;10218.69343919691;10329.483525823678;10368.377897326185;10389.376637401705;4166.458360413127;4267.786610669454;4329.9134017319475;4456.04195098049;4494.483134439516;9063.728088157366;9078.682246121354;9124.95437522808;9134.771630709152;9158.496282704515;4342.5006124296115;4386.517483076859;4392.516823149451;4393.472783266028;4423.933640995388;3618.7466877318334;3974.5429275633096;3988.2422339755353;3993.2412841560013;4093.1609020151395;3693.3351996640863;3738.7382883197915;3770.7737535747942;3818.293615681108;3839.865604703822;1221.108590728773;1237.826704261404;1238.9442475088642;1238.9504419823286;1254.8870601645895;939.3706216834737;972.4214092614883;972.7568107973007;1047.518141654832;1269.3272565540094;7087.078679771596;7167.139943206848;7191;7203;7223.783286501413;447.36250842549236;457.9679422440397;460.65220758327246;461.01343125711;462.9375034370384;5470.480304371078;5573.359063707644;5610.691411972299;5612.466815652589;5877;9219.216366608913;9581.904180958241;9595.328327017181;9597.088276613711;9612.855807162898;9295;9473.952630236943;9573.18627916635;9596.76008099803;9826.115649591571;7342.311268408403;7345.926540734631;7436.367908727819;7447.702091916371;7501.474896757175;7484.812879678052;7542.47202695806;7639.770806875803;7654.349380302737;7685.5004424712215;8797.428167169113;8874.423162494417;8926.107389261022;8926.73219803407;9003.369764116711;8703.91296087031;8831.955840220759;9079.591418386057;9127.08729127082;9191.172794448532;6167.506599471942;6770.356816102462;6813.69338379784;6992.300769922967;7028.6485675714985;7498.925010750041;7614.314711675976;7621.1616722161625;7628.694852206072;7639.465237433326;6602.141721576164;6728.192616886005;6863.965680171567;6900.585964842126;7012;6658.933410665832;6839.69221385029;6858.279880612663;6894.586324820527;6940.13248343957;7010.719571217298;7062.540934839219;7080.114985626797;7167.104111986002;7295;6416.967915160394;6440.774572889926;6477.287498375269;6498.252700939453;6513.5114866384265;6520.18497687789;6528.2492513359675;6545.639989800607;6573.3426657333885;6580.736770529125 17:35:48 INFO - PROCESS | 10962 | |4;prototype.html;314.8819192802699;315.5393126035987;319.07150192938525;320.8908970949877;323.9692229238222;5267.868303292415;5314.751033507127;5315.973420132904;5340.732963351837;5373.838784836461;5255.1329030709985;5261.736913154336;5275.314209152814;5283.762230699618;5318.521333080022;3866.3620502617105;3914.7846868422225;4045.858394956177;4075.9592404076025;4095.651869591088;4098.159877225176;4103.9794801025955;4116.238495878272;4128.195001974616;4131.153113611717;4091.2635725569385;4094.6110119538744;4105.384192371153;4106.5072191337085;4115.991582062399;3805.8667946621736;4005.6595189408936;4009.333793027633;4110.917781644365;4117.608827161415;3490.040238934288;3492.545969024036;3493.7903725776537;3499.9300013999577;3528.0826984984087;5049.2173713074535;5057.735566108473;5059.114654935372;5061.645684802065;5075.314832497603;4395.846145384896;4588.4035075440315;4600.07998400318;4601.631869450436;4645.210314246586;5492.862678433031;5526.47498487643;5531.3362396512275;5536.446355364472;5551.444855514456;3834.5398552173638;3854.2676891390547;3862.478565393664;3864.111254411473;3882.1753775725365;5673.943260567383;5769.163471296681;5775.566832487622;5804.129380592903;5842.211301474332;3951.130751234724;3954.5056867891512;3972.66232370246;3979.7015223858325;3982.2234664240195;3995.5604883462797;4024.6579040781276;4031.4759081319826;4040.7979601019833;4042.2319759245647;4615.792289346988;4618.145643056046;4620;4620.043172369619;4641.6054635355695;5422.674639521641;5427.213054107132;5515.172724091419;5544.63959842609;5554.250176226158;1380.4133243371527;1399.132537826554;1404.1645221093434;1412.6468382904275;1419.3258202354007;863.6588547523819;913.4199783137623;915.5696822493418;954.4416516337881;958.0658857613771;4750.168720473972;4774.379330686988;4801.807927682923;4833.842895110202;4835.927461088087;5625.493705566437;5664.20701101846;5668.659880407189;5702.059160238514;5734.197212390269;4645.558671926162;4784.6889952153;4825.420949486084;4832.51674832521;4834.734089625034;2994.431058098954;3043.4978228592477;3045.83247921362;3064.417760625474;3064.513710850236;5268.736563171826;5306.983346328448;5312.546844550995;5318.361796584435;5330.493603107699;5591.524720398812;5818.167277307634;5846.386129456431;5879.323877754113;5887.4701276884425;5293.444188360244;5309.283246761638;5320.334958130234;5350.27771250884;5360.41035486104;5462.071447853795;5676.489115979582;5685.516731077904;5708.771649134154;5721.22763426932;5554.50009499147;5554.611177217556;5572.192032155396;5574.630781917587;5605.355384130877;5308.513616187473;5325.866853328543;5357.276767636319;5357.437469065692;5374.892502149857;3648.543932008499;4002.4196491507987;4003.718809980778;4005.439238506553;4024.8188831502066;5707.828765137053;5712.257406537124;5719.342275638355;5719.656820590778;5724.398938111605;5490.231367608618;5514.944850551604;5525.778968841201;5556.499915007668;5557.610967232416;5338.866528336823;5526.447355264441;5544.861378465571;5546.084895992116;5573.303337082864;5161.406438259648;5385.865353366041;5438.537724293479;5441.374241962225;5449.373322068013;5403.216533602685;5557.916631250615;5585.804496842754;5604.159376093618;5623.3814280428305;5379.946200537945;5435.891282174413;5449.155380915964;5451.64564303319;5465.207544905887 17:35:48 INFO - PROCESS | 10962 | |5;yui.html;665.3911670821199;678.6911955060451;694.2190036209265;722.090166390348;747.6897087708601;11760.7647847043;12025.398730063505;12050.03599712023;12099.334536600494;12106.213096148744;12193;12212.32832194229;12215.511379544807;12236.44935977881;12282.63152105436;635.7520566978882;782.9804254893645;799.8000499875031;813.8331642013374;826.7313123234943;811.8335741173075;818.2104269380047;819.3813670678629;822.461287856455;823.8722997935299;857.8884744983144;860.0453496618779;860.6342304520585;860.9225169734723;864.3387808326635;846.0862268749736;849.8385306791752;850.5279569838737;850.5364576305928;852.6717213872641;630.6247782569363;633.591333589832;635.4566845347208;635.5900444213456;637.4581605635173;12719.427625756864;12725.172863763826;12823.807642885364;12846.743065138739;12873.098883078188;12464.127511074228;12664;12691;12769;12775.105742598022;11512.251703639236;11615.303081815118;11724.237924534878;11738.47176877034;11864.22882512634;4259.97870010648;4324.9135017299795;4335.934960975588;4450.621697155746;4459.2865141577195;45710;46133;46433.30350044752;47540;47933.281000784664;9871.457069861226;10082.899171008343;10089.142422894136;10175.643852465128;10387.480625968672;17323.133843308035;17337.2198251079;17341.65316693684;17346.65306693859;17368.21843017042;6842.418394436529;7012.684429200698;7037.824054398681;7196.856062878818;7310.853782924311;3809.8666546670734;3829.483019792348;3835.3096442640035;3852.5954774748247;3913.8043097844993;3263.951040734391;3433.296174284266;3438.6905178534053;3445.913852153666;3471.253680458663;598.6767145741338;605.6850437772333;609.472806022787;614.5575185866169;618.2519151826341;628.3527966194827;634.8825467288566;643.7099844263732;651.388171744051;656.2625845808172;8238.86538940035;8286;8532.829343413097;8622.353323500636;8626.482411055356;497.62318152364054;612.6477275566567;625.9155014073042;627.6359711367396;634.6763150793129;3975.5626881043063;3997.700172487075;4025.2352053110403;4102.774347410921;4217.156568686214;41042.38436423396;42237;51039.234411483856;51200;51646;36038;37424.25151496955;37541.436878446846;37622.43566346507;38496.80751596224;31939.520907186412;31998;33777.324453510795;36661;37166.81416592846;8246.546439945621;8371.706990255312;8638.740837774876;8688.52213128284;8743.169398907094;27567.86216068987;28109.859450703432;28330.433391331644;28459.43081138407;28700.13899583016;31851.362972739953;32823.67176328302;33752.49371259384;36200.45699314565;36980.44529332008;10543.630972916219;10820.56717731282;10938.179636527451;10964.232503724663;11106.944465277622;11380.715482113013;11988.160828741904;11991.64025079249;12136.393180341125;12464.68838279014;11435.542578296774;11436.428178590872;11609.709757255798;12108.757824843278;12147.878521214674;11155.442227888736;11349.205555611028;11587.362695051854;11672.241304315192;11749;11100.056495197676;11215.327080375204;11391.430428478709;11495.597654082067;11633.47649355764;9261.861072084059;9275.16523512887;9463.553733737477;9538.23694104456;9841.507924603598;8756.440024315221;9013.324000699842;9211.17099461025;9227.907720922705;9265.583048762957 17:35:48 INFO - PROCESS | 10962 | __end_tp_report 17:35:48 INFO - PROCESS | 10962 | __start_cc_report 17:35:48 INFO - PROCESS | 10962 | _x_x_mozilla_cycle_collect,384 17:35:48 INFO - PROCESS | 10962 | __end_cc_report 17:35:48 INFO - PROCESS | 10962 | __startTimestamp1460507748443__endTimestamp 17:35:48 INFO - PROCESS | 10962 | 17:35:48 INFO - PROCESS | 10962 | ------- Summary: start ------- 17:35:48 INFO - PROCESS | 10962 | Number of tests: 6 17:35:48 INFO - PROCESS | 10962 | 17:35:48 INFO - PROCESS | 10962 | [#0] dojo.html Cycles:165 Average:4726.99 Median:4845.59 stddev:500.03 (10.3%) stddev-sans-first:473.14 17:35:48 INFO - PROCESS | 10962 | Values: 2608.5 2661.9 2720.3 2722.3 2740.5 4765.6 4765.7 4786.7 4788.4 4847.4 4645.3 4782.0 4827.5 4855.1 4865.7 4369.9 4409.2 4437.7 4489.9 4508.9 4433.9 4440.7 4491.5 4510.1 4538.2 4267.9 4365.6 4390.1 4441.2 4462.3 4367.3 4377.4 4387.0 4396.3 4422.0 4353.8 4379.9 4383.8 4385.4 4405.5 4490.1 4563.8 4635.0 4647.9 4669.0 5114.4 5134.7 5157.5 5157.9 5211.9 5170.1 5174.7 5177.4 5179.7 5186.8 4678.7 4774.4 4801.0 4830.0 4855.2 5262.2 5306.8 5314.0 5323.1 5352.3 4921.3 5077.1 5078.6 5080.8 5081.0 4984.3 5159.5 5196.2 5216.6 5251.2 5002.1 5021.9 5032.3 5037.4 5088.8 5114.7 5118.6 5129.0 5130.9 5177.4 4292.8 4370.0 4374.1 4398.5 4410.0 3740.6 3740.9 3747.5 3771.2 3790.1 4353.1 4370.2 4381.0 4400.6 4431.2 5049.2 5062.0 5102.3 5135.6 5148.0 4346.4 4355.2 4387.7 4393.7 4429.4 4520.8 4554.7 4580.6 4660.7 4719.3 4809.6 4816.6 4830.3 4865.7 4897.7 5146.2 5150.5 5154.9 5157.6 5180.2 4636.2 4800.3 4812.8 4883.0 4909.8 5075.2 5091.5 5097.5 5107.5 5145.7 5153.4 5168.0 5173.0 5181.6 5183.2 4845.6 4917.5 4968.1 4980.7 5000.8 4814.0 4900.8 4905.9 4911.7 4915.0 4751.6 4793.2 4868.5 4875.5 4928.3 4984.7 4992.5 4996.8 4998.5 5047.1 4785.9 4790.4 4847.5 4889.7 4931.4 17:35:48 INFO - PROCESS | 10962 | 17:35:48 INFO - PROCESS | 10962 | [#1] ext.html Cycles:180 Average:35693.70 Median:18776.08 stddev:53786.49 (286.5%) stddev-sans-first:53872.72 17:35:48 INFO - PROCESS | 10962 | Values: 570.6 608.9 613.4 628.4 633.7 34590.8 35611.3 35916.6 35925.6 36022.6 36118.8 36641.8 36663.6 36737.0 36840.8 7569.8 7683.5 7704.8 7722.7 7724.3 7522.9 7741.1 7757.1 7775.1 7793.0 7723.1 7773.6 7787.6 7792.4 7799.1 7697.6 7776.8 7778.2 7791.2 7810.9 7739.7 7760.5 7775.6 7838.8 7843.1 30209.2 36981.8 37151.6 37329.8 37480.8 2802.7 2886.2 2948.2 3163.6 3163.7 23812.0 24306.5 24367.4 24509.8 24744.9 3064.1 3114.1 3125.6 3194.1 3257.0 144629.0 145010.0 145453.0 145611.3 145703.3 31037.2 31085.4 31096.7 31280.8 31503.7 32083.0 32214.5 60746.4 62785.7 62820.7 12235.7 12434.9 12451.1 12464.3 12504.4 9094.8 9095.8 9108.2 9117.9 9138.7 18391.5 18393.2 18458.6 18592.2 18650.3 7051.2 7074.9 7234.5 7320.2 7433.7 894.7 990.1 1000.2 1026.5 1064.0 26655.5 27196.9 27201.7 27202.5 27315.3 1024.7 1026.6 1057.7 1068.5 1086.9 14215.7 14744.3 14875.7 15079.5 15092.7 156201.0 156595.2 157316.0 157650.0 158592.0 46982.5 48035.0 48225.3 48228.5 48262.5 1241.2 1262.8 1268.5 1271.9 1271.9 26601.7 27193.5 27738.2 28082.4 28182.0 41169.4 41859.0 42009.8 42310.8 42358.0 281806.0 284341.0 285083.0 285089.0 286144.0 24800.9 25416.1 25562.6 25582.6 25676.5 40958.8 41174.4 41903.0 42004.8 42022.8 35107.0 35770.1 35781.6 36026.3 37062.8 34295.1 35199.3 35528.1 35574.5 35726.0 35491.5 35692.6 36090.0 37626.2 37720.8 27430.7 30697.8 30767.2 31050.4 31176.0 22835.7 23802.8 23942.9 24156.3 24293.5 17:35:48 INFO - PROCESS | 10962 | 17:35:48 INFO - PROCESS | 10962 | [#2] jquery.html Cycles:180 Average:24196.76 Median:410893.00 stddev:61169.80 (14.9%) stddev-sans-first:61315.23 17:35:48 INFO - PROCESS | 10962 | Values: 366.7 370.7 378.7 380.4 389.9 15789.5 16044.4 16826.4 16837.8 16866.7 16049.9 16596.7 17305.5 17401.5 17473.9 5120.0 5303.0 5317.9 5331.8 5336.2 3650.8 5177.0 5606.6 5856.8 5945.3 5836.5 5839.2 5841.4 5842.4 5847.4 5719.5 6000.8 6008.3 6009.5 6013.3 4454.7 5158.7 5164.1 5241.1 5248.9 18482.8 18595.4 18961.7 19114.0 19156.9 1785.1 1815.1 1906.8 1921.1 1929.3 8243.3 9020.1 9026.6 13195.8 13645.5 1793.3 1818.2 1871.1 1872.6 1923.0 61811.1 61899.0 73835.3 77175.2 81498.0 15977.9 16286.8 16499.7 16549.1 16609.2 29595.7 29706.6 29922.9 29937.4 29989.0 7924.7 8138.3 8200.5 8329.5 8346.1 6504.2 6590.4 6608.3 6616.2 6687.9 8072.6 8145.7 8289.1 8328.5 8388.4 1663.5 1851.6 1858.4 1877.9 3382.2 846.5 853.5 862.9 866.8 907.1 15231.6 15384.7 15432.2 15747.2 15755.9 849.7 870.4 871.6 906.0 909.9 9156.5 9201.9 9246.8 9264.4 9438.7 307028.0 316019.0 392420.0 410841.0 410945.0 66752.3 73751.0 75313.0 75973.0 78578.0 990.6 990.8 1001.0 1040.2 1053.6 15144.5 15267.9 15368.0 15457.1 15893.8 33096.7 33299.7 33705.5 34237.5 34292.8 46665.5 47967.0 48641.0 48813.3 48996.8 7620.6 7686.7 7711.7 7806.1 7916.0 10606.8 10691.9 11405.2 11516.7 11764.4 10189.7 10234.4 10366.0 10401.8 10670.7 8817.3 9737.4 9999.3 10123.3 10345.6 10347.5 10497.7 10541.3 10583.6 10620.3 7497.3 7542.8 7698.2 7701.5 8015.9 9627.6 10342.3 10401.6 10402.3 10713.4 17:35:48 INFO - PROCESS | 10962 | 17:35:48 INFO - PROCESS | 10962 | [#3] mootools.html Cycles:180 Average:5445.29 Median:6524.22 stddev:2898.41 (44.4%) stddev-sans-first:2889.56 17:35:48 INFO - PROCESS | 10962 | Values: 1272.0 1369.7 1371.8 1793.5 1829.1 6951.7 7574.7 7698.0 7843.4 7854.9 7709.8 7792.0 7828.9 7853.5 7865.8 2278.7 2305.1 2315.5 2324.4 2325.0 2197.7 2227.7 2256.8 2271.4 2272.2 2202.4 2213.7 2239.5 2256.6 2266.7 2232.7 2271.4 2282.0 2282.5 2289.3 2208.0 2209.1 2220.5 2222.0 2224.5 7767.7 7863.5 7894.4 7897.7 7913.7 4295.6 4414.4 4431.1 4443.0 4467.3 2920.3 2944.6 3075.5 3088.1 3118.9 958.3 973.3 998.6 1008.8 1026.9 10200.5 10218.7 10329.5 10368.4 10389.4 4166.5 4267.8 4329.9 4456.0 4494.5 9063.7 9078.7 9125.0 9134.8 9158.5 4342.5 4386.5 4392.5 4393.5 4423.9 3618.7 3974.5 3988.2 3993.2 4093.2 3693.3 3738.7 3770.8 3818.3 3839.9 1221.1 1237.8 1238.9 1239.0 1254.9 939.4 972.4 972.8 1047.5 1269.3 7087.1 7167.1 7191.0 7203.0 7223.8 447.4 458.0 460.7 461.0 462.9 5470.5 5573.4 5610.7 5612.5 5877.0 9219.2 9581.9 9595.3 9597.1 9612.9 9295.0 9474.0 9573.2 9596.8 9826.1 7342.3 7345.9 7436.4 7447.7 7501.5 7484.8 7542.5 7639.8 7654.3 7685.5 8797.4 8874.4 8926.1 8926.7 9003.4 8703.9 8832.0 9079.6 9127.1 9191.2 6167.5 6770.4 6813.7 6992.3 7028.6 7498.9 7614.3 7621.2 7628.7 7639.5 6602.1 6728.2 6864.0 6900.6 7012.0 6658.9 6839.7 6858.3 6894.6 6940.1 7010.7 7062.5 7080.1 7167.1 7295.0 6417.0 6440.8 6477.3 6498.3 6513.5 6520.2 6528.2 6545.6 6573.3 6580.7 17:35:48 INFO - PROCESS | 10962 | 17:35:48 INFO - PROCESS | 10962 | [#4] prototype.html Cycles:180 Average:4562.18 Median:5279.54 stddev:1341.08 (25.4%) stddev-sans-first:1306.40 17:35:48 INFO - PROCESS | 10962 | Values: 314.9 315.5 319.1 320.9 324.0 5267.9 5314.8 5316.0 5340.7 5373.8 5255.1 5261.7 5275.3 5283.8 5318.5 3866.4 3914.8 4045.9 4076.0 4095.7 4098.2 4104.0 4116.2 4128.2 4131.2 4091.3 4094.6 4105.4 4106.5 4116.0 3805.9 4005.7 4009.3 4110.9 4117.6 3490.0 3492.5 3493.8 3499.9 3528.1 5049.2 5057.7 5059.1 5061.6 5075.3 4395.8 4588.4 4600.1 4601.6 4645.2 5492.9 5526.5 5531.3 5536.4 5551.4 3834.5 3854.3 3862.5 3864.1 3882.2 5673.9 5769.2 5775.6 5804.1 5842.2 3951.1 3954.5 3972.7 3979.7 3982.2 3995.6 4024.7 4031.5 4040.8 4042.2 4615.8 4618.1 4620.0 4620.0 4641.6 5422.7 5427.2 5515.2 5544.6 5554.3 1380.4 1399.1 1404.2 1412.6 1419.3 863.7 913.4 915.6 954.4 958.1 4750.2 4774.4 4801.8 4833.8 4835.9 5625.5 5664.2 5668.7 5702.1 5734.2 4645.6 4784.7 4825.4 4832.5 4834.7 2994.4 3043.5 3045.8 3064.4 3064.5 5268.7 5307.0 5312.5 5318.4 5330.5 5591.5 5818.2 5846.4 5879.3 5887.5 5293.4 5309.3 5320.3 5350.3 5360.4 5462.1 5676.5 5685.5 5708.8 5721.2 5554.5 5554.6 5572.2 5574.6 5605.4 5308.5 5325.9 5357.3 5357.4 5374.9 3648.5 4002.4 4003.7 4005.4 4024.8 5707.8 5712.3 5719.3 5719.7 5724.4 5490.2 5514.9 5525.8 5556.5 5557.6 5338.9 5526.4 5544.9 5546.1 5573.3 5161.4 5385.9 5438.5 5441.4 5449.4 5403.2 5557.9 5585.8 5604.2 5623.4 5379.9 5435.9 5449.2 5451.6 5465.2 17:35:48 INFO - PROCESS | 10962 | 17:35:48 INFO - PROCESS | 10962 | [#5] yui.html Cycles:180 Average:12212.40 Median:4011.47 stddev:12844.28 (320.2%) stddev-sans-first:12851.04 17:35:48 INFO - PROCESS | 10962 | Values: 665.4 678.7 694.2 722.1 747.7 11760.8 12025.4 12050.0 12099.3 12106.2 12193.0 12212.3 12215.5 12236.4 12282.6 635.8 783.0 799.8 813.8 826.7 811.8 818.2 819.4 822.5 823.9 857.9 860.0 860.6 860.9 864.3 846.1 849.8 850.5 850.5 852.7 630.6 633.6 635.5 635.6 637.5 12719.4 12725.2 12823.8 12846.7 12873.1 12464.1 12664.0 12691.0 12769.0 12775.1 11512.3 11615.3 11724.2 11738.5 11864.2 4260.0 4324.9 4335.9 4450.6 4459.3 45710.0 46133.0 46433.3 47540.0 47933.3 9871.5 10082.9 10089.1 10175.6 10387.5 17323.1 17337.2 17341.7 17346.7 17368.2 6842.4 7012.7 7037.8 7196.9 7310.9 3809.9 3829.5 3835.3 3852.6 3913.8 3264.0 3433.3 3438.7 3445.9 3471.3 598.7 605.7 609.5 614.6 618.3 628.4 634.9 643.7 651.4 656.3 8238.9 8286.0 8532.8 8622.4 8626.5 497.6 612.6 625.9 627.6 634.7 3975.6 3997.7 4025.2 4102.8 4217.2 41042.4 42237.0 51039.2 51200.0 51646.0 36038.0 37424.3 37541.4 37622.4 38496.8 31939.5 31998.0 33777.3 36661.0 37166.8 8246.5 8371.7 8638.7 8688.5 8743.2 27567.9 28109.9 28330.4 28459.4 28700.1 31851.4 32823.7 33752.5 36200.5 36980.4 10543.6 10820.6 10938.2 10964.2 11106.9 11380.7 11988.2 11991.6 12136.4 12464.7 11435.5 11436.4 11609.7 12108.8 12147.9 11155.4 11349.2 11587.4 11672.2 11749.0 11100.1 11215.3 11391.4 11495.6 11633.5 9261.9 9275.2 9463.6 9538.2 9841.5 8756.4 9013.3 9211.2 9227.9 9265.6 17:35:48 INFO - PROCESS | 10962 | -------- Summary: end -------- 17:35:48 INFO - PROCESS | 10962 | 17:35:49 INFO - TEST-INFO | 10962: exit 0 17:35:49 INFO - TEST-OK | dromaeo_css | took 1115505ms 17:35:49 INFO - TEST-START | kraken 17:35:49 INFO - operating with platform_type : linux_ 17:35:49 INFO - Initialising browser for kraken test... 17:35:49 INFO - TEST-INFO | started process 11197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB9BypY/profile http://localhost:34672/getInfo.html) 17:35:53 INFO - PROCESS | 11197 | 17:35:53 INFO - PROCESS | 11197 | (process:11265): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:35:53 INFO - PROCESS | 11197 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:35:53 INFO - PROCESS | 11197 | __metrics Screen width/height:1600/1200 17:35:53 INFO - PROCESS | 11197 | colorDepth:24 17:35:53 INFO - PROCESS | 11197 | Browser inner width/height: 1024/697 17:35:53 INFO - PROCESS | 11197 | __metrics 17:35:54 ERROR - PROCESS | 11197 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:35:55 INFO - TEST-INFO | 11197: exit 0 17:35:55 INFO - Browser initialized. 17:35:55 INFO - Running cycle 1/1 for kraken test... 17:35:55 INFO - TEST-INFO | started process 11316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB9BypY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:57 INFO - PROCESS | 11316 | 17:35:57 INFO - PROCESS | 11316 | (process:11375): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:36:07 INFO - PROCESS | 11316 | RSS: Main: 164257792 17:36:07 INFO - PROCESS | 11316 | 17:36:10 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34672/tests/kraken/driver.html?testName=audio-beat-detection) 17:36:11 INFO - PROCESS | 11316 | RSS: Main: 168439808 17:36:11 INFO - PROCESS | 11316 | 17:36:13 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34672/tests/kraken/driver.html?testName=audio-dft) 17:36:14 INFO - PROCESS | 11316 | RSS: Main: 172199936 17:36:14 INFO - PROCESS | 11316 | 17:36:17 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34672/tests/kraken/driver.html?testName=audio-fft) 17:36:18 INFO - PROCESS | 11316 | RSS: Main: 163733504 17:36:18 INFO - PROCESS | 11316 | 17:36:20 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34672/tests/kraken/driver.html?testName=audio-oscillator) 17:36:20 INFO - PROCESS | 11316 | RSS: Main: 164249600 17:36:20 INFO - PROCESS | 11316 | 17:36:23 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34672/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:36:23 INFO - PROCESS | 11316 | RSS: Main: 164687872 17:36:23 INFO - PROCESS | 11316 | 17:36:26 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34672/tests/kraken/driver.html?testName=imaging-darkroom) 17:36:27 INFO - PROCESS | 11316 | RSS: Main: 165253120 17:36:27 INFO - PROCESS | 11316 | 17:36:31 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34672/tests/kraken/driver.html?testName=imaging-desaturate) 17:36:31 INFO - PROCESS | 11316 | RSS: Main: 164782080 17:36:31 INFO - PROCESS | 11316 | 17:36:34 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34672/tests/kraken/driver.html?testName=json-parse-financial) 17:36:35 INFO - PROCESS | 11316 | RSS: Main: 165261312 17:36:35 INFO - PROCESS | 11316 | 17:36:37 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34672/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:36:37 INFO - PROCESS | 11316 | RSS: Main: 165593088 17:36:37 INFO - PROCESS | 11316 | 17:36:39 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34672/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:36:40 INFO - PROCESS | 11316 | RSS: Main: 165830656 17:36:40 INFO - PROCESS | 11316 | 17:36:42 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34672/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:36:43 INFO - PROCESS | 11316 | RSS: Main: 166019072 17:36:43 INFO - PROCESS | 11316 | 17:36:45 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:36:46 INFO - PROCESS | 11316 | RSS: Main: 166424576 17:36:46 INFO - PROCESS | 11316 | 17:36:49 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:36:50 INFO - PROCESS | 11316 | RSS: Main: 165986304 17:36:50 INFO - PROCESS | 11316 | 17:36:51 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:34672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34672/tests/kraken/driver.html?testName=ai-astar) 17:36:52 INFO - PROCESS | 11316 | RSS: Main: 167964672 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | __start_tp_report 17:36:52 INFO - PROCESS | 11316 | _x_x_mozilla_page_load 17:36:52 INFO - PROCESS | 11316 | _x_x_mozilla_page_load_details 17:36:52 INFO - PROCESS | 11316 | |i|pagename|runs| 17:36:52 INFO - PROCESS | 11316 | |0;ai-astar;115;109;114;116;117;126;116;115;113;114 17:36:52 INFO - PROCESS | 11316 | |1;audio-beat-detection;158;131;163;189;144;168;165;138;202;132 17:36:52 INFO - PROCESS | 11316 | |2;audio-dft;165;163;165;174;161;165;162;163;165;165 17:36:52 INFO - PROCESS | 11316 | |3;audio-fft;75;72;85;164;78;78;74;78;152;78 17:36:52 INFO - PROCESS | 11316 | |4;audio-oscillator;96;94;149;93;94;93;137;94;95;147 17:36:52 INFO - PROCESS | 11316 | |5;imaging-gaussian-blur;118;118;117;118;118;118;118;118;119;118 17:36:52 INFO - PROCESS | 11316 | |6;imaging-darkroom;148;147;148;147;147;148;147;147;147;149 17:36:52 INFO - PROCESS | 11316 | |7;imaging-desaturate;96;97;96;97;97;97;97;96;96;97 17:36:52 INFO - PROCESS | 11316 | |8;json-parse-financial;66;65;64;65;65;66;68;84;62;62 17:36:52 INFO - PROCESS | 11316 | |9;json-stringify-tinderbox;66;65;64;65;64;64;65;65;64;64 17:36:52 INFO - PROCESS | 11316 | |10;stanford-crypto-aes;86;86;87;85;88;87;88;86;87;86 17:36:52 INFO - PROCESS | 11316 | |11;stanford-crypto-ccm;148;148;138;140;142;137;139;142;171;143 17:36:52 INFO - PROCESS | 11316 | |12;stanford-crypto-pbkdf2;180;182;180;173;172;177;172;173;177;173 17:36:52 INFO - PROCESS | 11316 | |13;stanford-crypto-sha256-iterative;73;74;72;74;73;71;71;76;71;74 17:36:52 INFO - PROCESS | 11316 | __end_tp_report 17:36:52 INFO - PROCESS | 11316 | __start_cc_report 17:36:52 INFO - PROCESS | 11316 | _x_x_mozilla_cycle_collect,935 17:36:52 INFO - PROCESS | 11316 | __end_cc_report 17:36:52 INFO - PROCESS | 11316 | __startTimestamp1460507812142__endTimestamp 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | ------- Summary: start ------- 17:36:52 INFO - PROCESS | 11316 | Number of tests: 14 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:4.30 (3.7%) stddev-sans-first:4.56 17:36:52 INFO - PROCESS | 11316 | Values: 115.0 109.0 114.0 116.0 117.0 126.0 116.0 115.0 113.0 114.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#1] audio-beat-detection Cycles:10 Average:159.00 Median:164.00 stddev:23.72 (14.5%) stddev-sans-first:25.15 17:36:52 INFO - PROCESS | 11316 | Values: 158.0 131.0 163.0 189.0 144.0 168.0 165.0 138.0 202.0 132.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:3.55 (2.2%) stddev-sans-first:3.77 17:36:52 INFO - PROCESS | 11316 | Values: 165.0 163.0 165.0 174.0 161.0 165.0 162.0 163.0 165.0 165.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#3] audio-fft Cycles:10 Average:93.40 Median:78.00 stddev:34.34 (44.0%) stddev-sans-first:35.77 17:36:52 INFO - PROCESS | 11316 | Values: 75.0 72.0 85.0 164.0 78.0 78.0 74.0 78.0 152.0 78.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:94.00 stddev:24.45 (26.0%) stddev-sans-first:25.46 17:36:52 INFO - PROCESS | 11316 | Values: 96.0 94.0 149.0 93.0 94.0 93.0 137.0 94.0 95.0 147.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 17:36:52 INFO - PROCESS | 11316 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 119.0 118.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 17:36:52 INFO - PROCESS | 11316 | Values: 148.0 147.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 149.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:36:52 INFO - PROCESS | 11316 | Values: 96.0 97.0 96.0 97.0 97.0 97.0 97.0 96.0 96.0 97.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:65.50 stddev:6.34 (9.7%) stddev-sans-first:6.72 17:36:52 INFO - PROCESS | 11316 | Values: 66.0 65.0 64.0 65.0 65.0 66.0 68.0 84.0 62.0 62.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 17:36:52 INFO - PROCESS | 11316 | Values: 66.0 65.0 64.0 65.0 64.0 64.0 65.0 65.0 64.0 64.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:0.97 (1.1%) stddev-sans-first:1.00 17:36:52 INFO - PROCESS | 11316 | Values: 86.0 86.0 87.0 85.0 88.0 87.0 88.0 86.0 87.0 86.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:142.50 stddev:9.94 (7.0%) stddev-sans-first:10.48 17:36:52 INFO - PROCESS | 11316 | Values: 148.0 148.0 138.0 140.0 142.0 137.0 139.0 142.0 171.0 143.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:177.00 stddev:3.78 (2.1%) stddev-sans-first:3.71 17:36:52 INFO - PROCESS | 11316 | Values: 180.0 182.0 180.0 173.0 172.0 177.0 172.0 173.0 177.0 173.0 17:36:52 INFO - PROCESS | 11316 | 17:36:52 INFO - PROCESS | 11316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.50 stddev:1.66 (2.3%) stddev-sans-first:1.76 17:36:52 INFO - PROCESS | 11316 | Values: 73.0 74.0 72.0 74.0 73.0 71.0 71.0 76.0 71.0 74.0 17:36:52 INFO - PROCESS | 11316 | -------- Summary: end -------- 17:36:52 INFO - PROCESS | 11316 | 17:36:53 INFO - TEST-INFO | 11316: exit 0 17:36:53 INFO - TEST-OK | kraken | took 63991ms 17:36:53 INFO - SUITE-END | took 1179s 17:36:53 INFO - Completed test suite (00:19:39) 17:36:53 INFO - javascript benchmark 17:36:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.478304339132, 2661.866906654667, 2720.279126031603, 2722.3330284080403, 2740.4930087933735, 4765.642576806736, 4765.714057156569, 4786.712797232164, 4788.399259484737, 4847.418309802829, 4645.279981602857, 4782.0, 4827.468978412372, 4855.126077306083, 4865.708057516552, 4369.93445098323, 4409.206342858284, 4437.689361744679, 4489.910201795962, 4508.909821803562, 4433.935855394714, 4440.666949978765, 4491.4610246770435, 4510.097980403916, 4538.205813982557, 4267.914641707149, 4365.563443655641, 4390.100029493946, 4441.244988351988, 4462.308342206963, 4367.344898265285, 4377.387165796791, 4387.0129220925355, 4396.296592545209, 4421.955780442187, 4353.760543170124, 4379.934300985487, 4383.82806027017, 4385.429894113777, 4405.471343438808, 4490.146872094291, 4563.794629241692, 4634.95365046352, 4647.88380290492, 4668.976655116703, 5114.386273647149, 5134.666246693953, 5157.458466860963, 5157.896842063138, 5211.921821172686, 5170.146925757245, 5174.689518628894, 5177.404598471187, 5179.741012949337, 5186.844394668166, 4678.672492925497, 4774.379330687023, 4800.975995120072, 4829.95170048302, 4855.150348688965, 5262.210668399694, 5306.8407947761625, 5314.0, 5323.0684630190335, 5352.2506849041165, 4921.311016457699, 5077.060743762416, 5078.619103567247, 5080.822171224063, 5081.0, 4984.27727979441, 5159.509846564571, 5196.194589838581, 5216.58267338612, 5251.238570407346, 5002.09962206799, 5021.949780502221, 5032.295478632995, 5037.3955125384455, 5088.796448142107, 5114.744262786846, 5118.564921981599, 5128.974355128201, 5130.87172820675, 5177.378714554277, 4292.849750258726, 4369.978150109293, 4374.059577190919, 4398.494173170063, 4410.007748256617, 3740.6259374062374, 3740.8877733668032, 3747.512823332949, 3771.2080463103057, 3790.090378309186, 4353.085851971058, 4370.191514569815, 4380.978095109568, 4400.581944715247, 4431.224535706238, 5049.2426136079885, 5061.974690126526, 5102.285680004802, 5135.6148288878485, 5148.047611191867, 4346.391505189276, 4355.216061109031, 4387.670924680598, 4393.7363758174615, 4429.402030725811, 4520.796564154621, 4554.658400619966, 4580.564846339593, 4660.720356778605, 4719.268513380432, 4809.615230781459, 4816.590589799906, 4830.2513110467935, 4865.7323847188745, 4897.681650692693, 5146.176611742103, 5150.536451719363, 5154.922676159786, 5157.613179011514, 5180.248863914787, 4636.235021221461, 4800.279958006327, 4812.807487700453, 4882.95117048825, 4909.77905994224, 5075.2387141929, 5091.490850914879, 5097.464766199496, 5107.540321371094, 5145.691258524501, 5153.433122356463, 5167.974160129175, 5173.0, 5181.585473162213, 5183.222516622537, 4845.5881250094135, 4917.5328343808715, 4968.056069346812, 4980.701157930535, 5000.849974500771, 4813.95186048149, 4900.779464924016, 4905.9018819624125, 4911.68074075184, 4914.950850491592, 4751.572358487752, 4793.209120495079, 4868.513148685245, 4875.488073752205, 4928.310036594951, 4984.675996060245, 4992.475790042138, 4996.825111121093, 4998.525140111829, 5047.1419858623385, 4785.880352991064, 4790.377250957354, 4847.515248475124, 4889.682170658896, 4931.3835770528685], "value": 4695.105264991629, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5692202387197, 608.9025755879057, 613.3804857094335, 628.4312697009208, 633.7053270229344, 34590.82704586477, 35611.2877742445, 35916.64083359166, 35925.64074359256, 36022.63977360232, 36118.819405903, 36641.81679091608, 36663.633363666355, 36737.0, 36840.81579592105, 7569.810754731121, 7683.538987660758, 7704.845903081935, 7722.652480638385, 7724.266194711493, 7522.887156692654, 7741.071071471431, 7757.107932587768, 7775.105862825762, 7792.961035194816, 7723.111842138142, 7773.611319434006, 7787.610619469032, 7792.415568832332, 7799.064112306532, 7697.576633285167, 7776.844463110762, 7778.183290754502, 7791.181925897756, 7810.921890781076, 7739.6904123834975, 7760.456768026241, 7775.611219439062, 7838.804029899241, 7843.058832940027, 30209.244768880733, 36981.81509092464, 37151.62848371509, 37329.81335093334, 37480.81259593685, 2802.6776920654183, 2886.1774394297527, 2948.189247956808, 3163.57291765611, 3163.7152656261046, 23812.0, 24306.513869722505, 24367.390815229584, 24509.754902450924, 24744.876275618688, 3064.1114076917665, 3114.112477943798, 3125.562421261025, 3194.073718621597, 3257.0228931320507, 144629.0, 145010.0, 145453.0, 145611.27194364066, 145703.27148364295, 31037.224069397995, 31085.378292434478, 31096.689033109833, 31280.843595781877, 31503.684963150532, 32083.0, 32214.516782248284, 60746.392536074956, 62785.68607156935, 62820.68589657023, 12235.694107647201, 12434.875651243552, 12451.128421010624, 12464.252144871336, 12504.3747812609, 9094.81810363789, 9095.772605684779, 9108.225800806873, 9117.908820911705, 9138.68014619485, 18391.54021149482, 18393.172307246205, 18458.63082738338, 18592.163352649164, 18650.34723784661, 7051.1891132519395, 7074.92925070753, 7234.493585448968, 7320.194778574352, 7433.665485053186, 894.7494701483595, 990.1237404896574, 1000.2048371544639, 1026.5175367577226, 1064.031731124673, 26655.466890662465, 27196.864015679796, 27201.72798271992, 27202.45595088087, 27315.31711707223, 1024.6925922223304, 1026.5688410867454, 1057.7197042783669, 1068.4550879051585, 1086.9402182880017, 14215.715685686228, 14744.262786860614, 14875.70248595022, 15079.54761357161, 15092.698146037017, 156201.0, 156595.21702391416, 157316.0, 157650.0, 158592.0, 46982.5301746985, 48035.0, 48225.27662085072, 48228.5177148224, 48262.51737482651, 1241.2428418664608, 1262.7537630162215, 1268.5243033862303, 1271.8728127187392, 1271.8918891894107, 26601.733982659927, 27193.45613087767, 27738.167854964384, 28082.438351233268, 28182.0, 41169.38245926254, 41859.0, 42009.78995105005, 42310.78844605757, 42358.0, 281806.0, 284341.0, 285083.0, 285089.0, 286144.0, 24800.875995619906, 25416.110436134648, 25562.616560751976, 25582.616260756477, 25676.486470270862, 40958.79520602378, 41174.38238426366, 41903.0, 42004.78997604993, 42022.78988605038, 35107.0, 35770.10574735548, 35781.64218357887, 36026.27947441089, 37062.814685926394, 34295.142621434665, 35199.29601407906, 35528.111797205274, 35574.46638300376, 35726.0, 35491.467627986116, 35692.64307356997, 36090.0, 37626.2474750498, 37720.811395942845, 27430.725692742817, 30697.846510767304, 30767.2308192297, 31050.378992420476, 31176.0, 22835.657465138367, 23802.761972380056, 23942.880285599156, 24156.275311740676, 24293.514129716954], "value": 16121.349913754022, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.6645019806877, 370.6552905797608, 378.7027183660827, 380.40656575741826, 389.9376099824029, 15789.526314210578, 16044.438444654439, 16826.411075612355, 16837.83162168378, 16866.66266674666, 16049.919750401232, 16596.66806663866, 17305.480835574952, 17401.477955661318, 17473.912630436862, 5120.0, 5303.045451818671, 5317.867053323659, 5331.813386531472, 5336.226247194155, 3650.7992060436663, 5177.0, 5606.55147588194, 5856.824295271149, 5945.256842894638, 5836.5038971687245, 5839.182514447981, 5841.357450680422, 5842.357340692521, 5847.356790753014, 5719.542436605082, 6000.789972350991, 6008.309044459856, 6009.4591486766185, 6013.278406591237, 4454.688171827974, 5158.716270605115, 5164.147915593922, 5241.082810508184, 5248.895022099537, 18482.81517184838, 18595.44213673592, 18961.715574266396, 19114.044297785193, 19156.946367949757, 1785.098525244756, 1815.1015247452463, 1906.761654793151, 1921.0586812461793, 1929.2861641192708, 8243.340532757366, 9020.097990200993, 9026.638934442615, 13195.802062969064, 13645.522406715718, 1793.3095758133081, 1818.1545581304624, 1871.1112221694723, 1872.616113696689, 1922.9615407691908, 61811.07283390708, 61899.0, 73835.26164738338, 77175.22824771737, 81497.9999999994, 15977.920110399606, 16286.755698664529, 16499.6700065998, 16549.089800060872, 16609.169541522875, 29595.704042959296, 29706.554401683992, 29922.850385748367, 29937.401251975276, 29989.0, 7924.683012679428, 8138.3082437993435, 8200.507969521848, 8329.541875196923, 8346.081930987586, 6504.15445992018, 6590.439812615981, 6608.3391660834495, 6616.239132499728, 6687.866242675119, 8072.636731346986, 8145.71489997859, 8289.129641387688, 8328.500289982621, 8388.37087218461, 1663.517579901815, 1851.6024441950367, 1858.4053103006909, 1877.8873267603988, 3382.2051817822794, 846.5344060766554, 853.4665833853842, 862.8748831419409, 866.8049688819965, 907.0521305235912, 15231.619209519851, 15384.692306153815, 15432.15123168214, 15747.212639368216, 15755.921220394053, 849.6643825688818, 870.4429165334191, 871.5859966515981, 905.981880362389, 909.8589718593629, 9156.542172891328, 9201.861972070425, 9246.815063698823, 9264.44413335202, 9438.716838494856, 307028.0, 316019.0, 392420.0, 410841.0, 410945.0, 66752.33247667461, 73751.0, 75313.0, 75973.0, 78578.0, 990.5740531571494, 990.7671697151163, 1000.9699709008596, 1040.2198351236573, 1053.578568572577, 15144.54566363011, 15267.923660381626, 15368.001079929769, 15457.149856757986, 15893.761593575875, 33096.66903330936, 33299.667003329654, 33705.49441758425, 34237.48643770296, 34292.82853585716, 46665.53334466748, 47967.0, 48641.0, 48813.26780098231, 48996.75501622469, 7620.5808680523105, 7686.6541005656, 7711.691532338644, 7806.102298235548, 7916.0, 10606.787864242826, 10691.8930810694, 11405.20163588574, 11516.654500365003, 11764.411779411166, 10189.74525636865, 10234.385936843813, 10366.0, 10401.84397234027, 10670.679879603624, 8817.294616430798, 9737.415755054719, 9999.250056245664, 10123.291369604058, 10345.63790267337, 10347.482625868826, 10497.737556561147, 10541.31481453703, 10583.576656933636, 10620.256582039183, 7497.250274972677, 7542.811429714082, 7698.191689872707, 7701.499402538817, 8015.879761803461, 9627.56675949598, 10342.32774869631, 10401.635942741968, 10402.27184097106, 10713.35719856811], "value": 8699.624191381303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.9745605087899, 1369.6644322141076, 1371.814805001325, 1793.5247159502742, 1829.067175740373, 6951.652417379136, 7574.659140338684, 7698.0, 7843.411744119193, 7854.882176767346, 7709.807254818632, 7791.961040194791, 7828.921710782891, 7853.528788272708, 7865.842683146334, 2278.7265528136604, 2305.13557415969, 2315.490592069742, 2324.418895276181, 2324.976750232501, 2197.6923230747707, 2227.7438094619083, 2256.7968882800546, 2271.432141964509, 2272.1820144747876, 2202.383332666856, 2213.734351877777, 2239.496113374494, 2256.6050941085327, 2266.6826644269813, 2232.698585690943, 2271.3867255840914, 2281.999999999992, 2282.47503074293, 2289.347535952246, 2207.9668804967937, 2209.1494774511766, 2220.4781876259226, 2221.9555608887895, 2224.4994876152896, 7767.6892924282965, 7863.488873223222, 7894.447388682795, 7897.6840926362875, 7913.683452661887, 4295.570442955711, 4414.426124603813, 4431.091626216617, 4442.977785111086, 4467.262901621229, 2920.32832448538, 2944.6024786653743, 3075.5079187330143, 3088.1044497095813, 3118.937621247585, 958.3195930889077, 973.2797729679986, 998.5855869814019, 1008.8284991551454, 1026.8870424253325, 10200.489975501196, 10218.69343919691, 10329.483525823678, 10368.377897326185, 10389.376637401705, 4166.458360413127, 4267.786610669454, 4329.9134017319475, 4456.04195098049, 4494.483134439516, 9063.728088157366, 9078.682246121354, 9124.95437522808, 9134.771630709152, 9158.496282704515, 4342.5006124296115, 4386.517483076859, 4392.516823149451, 4393.472783266028, 4423.933640995388, 3618.7466877318334, 3974.5429275633096, 3988.2422339755353, 3993.2412841560013, 4093.1609020151395, 3693.3351996640863, 3738.7382883197915, 3770.7737535747942, 3818.293615681108, 3839.865604703822, 1221.108590728773, 1237.826704261404, 1238.9442475088642, 1238.9504419823286, 1254.8870601645895, 939.3706216834737, 972.4214092614883, 972.7568107973007, 1047.518141654832, 1269.3272565540094, 7087.078679771596, 7167.139943206848, 7191.0, 7203.0, 7223.783286501413, 447.36250842549236, 457.9679422440397, 460.65220758327246, 461.01343125711, 462.9375034370384, 5470.480304371078, 5573.359063707644, 5610.691411972299, 5612.466815652589, 5877.0, 9219.216366608913, 9581.904180958241, 9595.328327017181, 9597.088276613711, 9612.855807162898, 9295.0, 9473.952630236943, 9573.18627916635, 9596.76008099803, 9826.115649591571, 7342.311268408403, 7345.926540734631, 7436.367908727819, 7447.702091916371, 7501.474896757175, 7484.812879678052, 7542.47202695806, 7639.770806875803, 7654.349380302737, 7685.5004424712215, 8797.428167169113, 8874.423162494417, 8926.107389261022, 8926.73219803407, 9003.369764116711, 8703.91296087031, 8831.955840220759, 9079.591418386057, 9127.08729127082, 9191.172794448532, 6167.506599471942, 6770.356816102462, 6813.69338379784, 6992.300769922967, 7028.6485675714985, 7498.925010750041, 7614.314711675976, 7621.1616722161625, 7628.694852206072, 7639.465237433326, 6602.141721576164, 6728.192616886005, 6863.965680171567, 6900.585964842126, 7012.0, 6658.933410665832, 6839.69221385029, 6858.279880612663, 6894.586324820527, 6940.13248343957, 7010.719571217298, 7062.540934839219, 7080.114985626797, 7167.104111986002, 7295.0, 6416.967915160394, 6440.774572889926, 6477.287498375269, 6498.252700939453, 6513.5114866384265, 6520.18497687789, 6528.2492513359675, 6545.639989800607, 6573.3426657333885, 6580.736770529125], "value": 4358.506784976787, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.8819192802699, 315.5393126035987, 319.07150192938525, 320.8908970949877, 323.9692229238222, 5267.868303292415, 5314.751033507127, 5315.973420132904, 5340.732963351837, 5373.838784836461, 5255.1329030709985, 5261.736913154336, 5275.314209152814, 5283.762230699618, 5318.521333080022, 3866.3620502617105, 3914.7846868422225, 4045.858394956177, 4075.9592404076025, 4095.651869591088, 4098.159877225176, 4103.9794801025955, 4116.238495878272, 4128.195001974616, 4131.153113611717, 4091.2635725569385, 4094.6110119538744, 4105.384192371153, 4106.5072191337085, 4115.991582062399, 3805.8667946621736, 4005.6595189408936, 4009.333793027633, 4110.917781644365, 4117.608827161415, 3490.040238934288, 3492.545969024036, 3493.7903725776537, 3499.9300013999577, 3528.0826984984087, 5049.2173713074535, 5057.735566108473, 5059.114654935372, 5061.645684802065, 5075.314832497603, 4395.846145384896, 4588.4035075440315, 4600.07998400318, 4601.631869450436, 4645.210314246586, 5492.862678433031, 5526.47498487643, 5531.3362396512275, 5536.446355364472, 5551.444855514456, 3834.5398552173638, 3854.2676891390547, 3862.478565393664, 3864.111254411473, 3882.1753775725365, 5673.943260567383, 5769.163471296681, 5775.566832487622, 5804.129380592903, 5842.211301474332, 3951.130751234724, 3954.5056867891512, 3972.66232370246, 3979.7015223858325, 3982.2234664240195, 3995.5604883462797, 4024.6579040781276, 4031.4759081319826, 4040.7979601019833, 4042.2319759245647, 4615.792289346988, 4618.145643056046, 4620.0, 4620.043172369619, 4641.6054635355695, 5422.674639521641, 5427.213054107132, 5515.172724091419, 5544.63959842609, 5554.250176226158, 1380.4133243371527, 1399.132537826554, 1404.1645221093434, 1412.6468382904275, 1419.3258202354007, 863.6588547523819, 913.4199783137623, 915.5696822493418, 954.4416516337881, 958.0658857613771, 4750.168720473972, 4774.379330686988, 4801.807927682923, 4833.842895110202, 4835.927461088087, 5625.493705566437, 5664.20701101846, 5668.659880407189, 5702.059160238514, 5734.197212390269, 4645.558671926162, 4784.6889952153, 4825.420949486084, 4832.51674832521, 4834.734089625034, 2994.431058098954, 3043.4978228592477, 3045.83247921362, 3064.417760625474, 3064.513710850236, 5268.736563171826, 5306.983346328448, 5312.546844550995, 5318.361796584435, 5330.493603107699, 5591.524720398812, 5818.167277307634, 5846.386129456431, 5879.323877754113, 5887.4701276884425, 5293.444188360244, 5309.283246761638, 5320.334958130234, 5350.27771250884, 5360.41035486104, 5462.071447853795, 5676.489115979582, 5685.516731077904, 5708.771649134154, 5721.22763426932, 5554.50009499147, 5554.611177217556, 5572.192032155396, 5574.630781917587, 5605.355384130877, 5308.513616187473, 5325.866853328543, 5357.276767636319, 5357.437469065692, 5374.892502149857, 3648.543932008499, 4002.4196491507987, 4003.718809980778, 4005.439238506553, 4024.8188831502066, 5707.828765137053, 5712.257406537124, 5719.342275638355, 5719.656820590778, 5724.398938111605, 5490.231367608618, 5514.944850551604, 5525.778968841201, 5556.499915007668, 5557.610967232416, 5338.866528336823, 5526.447355264441, 5544.861378465571, 5546.084895992116, 5573.303337082864, 5161.406438259648, 5385.865353366041, 5438.537724293479, 5441.374241962225, 5449.373322068013, 5403.216533602685, 5557.916631250615, 5585.804496842754, 5604.159376093618, 5623.3814280428305, 5379.946200537945, 5435.891282174413, 5449.155380915964, 5451.64564303319, 5465.207544905887], "value": 4134.247146499561, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.3911670821199, 678.6911955060451, 694.2190036209265, 722.090166390348, 747.6897087708601, 11760.7647847043, 12025.398730063505, 12050.03599712023, 12099.334536600494, 12106.213096148744, 12193.0, 12212.32832194229, 12215.511379544807, 12236.44935977881, 12282.63152105436, 635.7520566978882, 782.9804254893645, 799.8000499875031, 813.8331642013374, 826.7313123234943, 811.8335741173075, 818.2104269380047, 819.3813670678629, 822.461287856455, 823.8722997935299, 857.8884744983144, 860.0453496618779, 860.6342304520585, 860.9225169734723, 864.3387808326635, 846.0862268749736, 849.8385306791752, 850.5279569838737, 850.5364576305928, 852.6717213872641, 630.6247782569363, 633.591333589832, 635.4566845347208, 635.5900444213456, 637.4581605635173, 12719.427625756864, 12725.172863763826, 12823.807642885364, 12846.743065138739, 12873.098883078188, 12464.127511074228, 12664.0, 12691.0, 12769.0, 12775.105742598022, 11512.251703639236, 11615.303081815118, 11724.237924534878, 11738.47176877034, 11864.22882512634, 4259.97870010648, 4324.9135017299795, 4335.934960975588, 4450.621697155746, 4459.2865141577195, 45710.0, 46133.0, 46433.30350044752, 47540.0, 47933.281000784664, 9871.457069861226, 10082.899171008343, 10089.142422894136, 10175.643852465128, 10387.480625968672, 17323.133843308035, 17337.2198251079, 17341.65316693684, 17346.65306693859, 17368.21843017042, 6842.418394436529, 7012.684429200698, 7037.824054398681, 7196.856062878818, 7310.853782924311, 3809.8666546670734, 3829.483019792348, 3835.3096442640035, 3852.5954774748247, 3913.8043097844993, 3263.951040734391, 3433.296174284266, 3438.6905178534053, 3445.913852153666, 3471.253680458663, 598.6767145741338, 605.6850437772333, 609.472806022787, 614.5575185866169, 618.2519151826341, 628.3527966194827, 634.8825467288566, 643.7099844263732, 651.388171744051, 656.2625845808172, 8238.86538940035, 8286.0, 8532.829343413097, 8622.353323500636, 8626.482411055356, 497.62318152364054, 612.6477275566567, 625.9155014073042, 627.6359711367396, 634.6763150793129, 3975.5626881043063, 3997.700172487075, 4025.2352053110403, 4102.774347410921, 4217.156568686214, 41042.38436423396, 42237.0, 51039.234411483856, 51200.0, 51646.0, 36038.0, 37424.25151496955, 37541.436878446846, 37622.43566346507, 38496.80751596224, 31939.520907186412, 31998.0, 33777.324453510795, 36661.0, 37166.81416592846, 8246.546439945621, 8371.706990255312, 8638.740837774876, 8688.52213128284, 8743.169398907094, 27567.86216068987, 28109.859450703432, 28330.433391331644, 28459.43081138407, 28700.13899583016, 31851.362972739953, 32823.67176328302, 33752.49371259384, 36200.45699314565, 36980.44529332008, 10543.630972916219, 10820.56717731282, 10938.179636527451, 10964.232503724663, 11106.944465277622, 11380.715482113013, 11988.160828741904, 11991.64025079249, 12136.393180341125, 12464.68838279014, 11435.542578296774, 11436.428178590872, 11609.709757255798, 12108.757824843278, 12147.878521214674, 11155.442227888736, 11349.205555611028, 11587.362695051854, 11672.241304315192, 11749.0, 11100.056495197676, 11215.327080375204, 11391.430428478709, 11495.597654082067, 11633.47649355764, 9261.861072084059, 9275.16523512887, 9463.553733737477, 9538.23694104456, 9841.507924603598, 8756.440024315221, 9013.324000699842, 9211.17099461025, 9227.907720922705, 9265.583048762957], "value": 6045.548099589266, "unit": "score"}], "name": "dromaeo_css", "value": 6446.041802116314, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 116.0, 117.0, 126.0, 116.0, 115.0, 113.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 163.0, 189.0, 144.0, 168.0, 165.0, 138.0, 202.0, 132.0], "value": 159.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 174.0, 161.0, 165.0, 162.0, 163.0, 165.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 85.0, 164.0, 78.0, 78.0, 74.0, 78.0, 152.0, 78.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 149.0, 93.0, 94.0, 93.0, 137.0, 94.0, 95.0, 147.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 149.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 65.0, 66.0, 68.0, 84.0, 62.0, 62.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 85.0, 88.0, 87.0, 88.0, 86.0, 87.0, 86.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 138.0, 140.0, 142.0, 137.0, 139.0, 142.0, 171.0, 143.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 182.0, 180.0, 173.0, 172.0, 177.0, 172.0, 173.0, 177.0, 173.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 72.0, 74.0, 73.0, 71.0, 71.0, 76.0, 71.0, 74.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1615.5, "alertThreshold": 2.0}]} 17:36:53 INFO - Return code: 0 17:36:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:36:53 ERROR - # TBPL SUCCESS # 17:36:53 INFO - Running post-action listener: _resource_record_post_action 17:36:53 INFO - Running post-run listener: _resource_record_post_run 17:36:54 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 151552; Write bytes: 518795264; Read time: 372; Write time: 376944 17:36:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 69632; Write bytes: 233074688; Read time: 144; Write time: 230088 17:36:54 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 81920; Write bytes: 285122560; Read time: 228; Write time: 146856 17:36:54 INFO - Running post-run listener: _upload_blobber_files 17:36:54 INFO - Blob upload gear active. 17:36:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:36:54 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 17:36:54 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'] 17:36:54 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 17:36:54 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:36:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:36:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:55 INFO - (blobuploader) - INFO - Done attempting. 17:36:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:36:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:36:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:56 INFO - (blobuploader) - INFO - Done attempting. 17:36:56 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:56 INFO - Return code: 0 17:36:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:36:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d08a2c71bd172145787f9118e0a438db6c4d7c90d50f4eaef17df73012e0926f6a8b300671191bbe0741fd3514789cf05ec1ce37ff802076572063687954e38e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a6d2d924e3e34281723ddad2a4e47e368783062c641bbb7580fd291d5099b598b3bc24c1dabb644146973e15464d440ccbb2d7d173274f3788bef8b99bf0295"} 17:36:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:36:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:36:56 INFO - Contents: 17:36:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d08a2c71bd172145787f9118e0a438db6c4d7c90d50f4eaef17df73012e0926f6a8b300671191bbe0741fd3514789cf05ec1ce37ff802076572063687954e38e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a6d2d924e3e34281723ddad2a4e47e368783062c641bbb7580fd291d5099b598b3bc24c1dabb644146973e15464d440ccbb2d7d173274f3788bef8b99bf0295"} 17:36:56 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:56 INFO - Copying logs to upload dir... 17:36:56 INFO - mkdir: /builds/slave/test/build/upload/logs 17:36:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.528914 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-12 17:36:56.485281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 17:36:56.488738) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d08a2c71bd172145787f9118e0a438db6c4d7c90d50f4eaef17df73012e0926f6a8b300671191bbe0741fd3514789cf05ec1ce37ff802076572063687954e38e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a6d2d924e3e34281723ddad2a4e47e368783062c641bbb7580fd291d5099b598b3bc24c1dabb644146973e15464d440ccbb2d7d173274f3788bef8b99bf0295"} build_url:https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/GP_21_cKS-SJLxZtwQC4Ng/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d08a2c71bd172145787f9118e0a438db6c4d7c90d50f4eaef17df73012e0926f6a8b300671191bbe0741fd3514789cf05ec1ce37ff802076572063687954e38e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a6d2d924e3e34281723ddad2a4e47e368783062c641bbb7580fd291d5099b598b3bc24c1dabb644146973e15464d440ccbb2d7d173274f3788bef8b99bf0295"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 17:36:56.514046) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:36:56.514405) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1460506498.28473-66178842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:36:56.598270) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 17:36:56.598611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 17:36:56.598909) ========= ========= Total master_lag: 0.31 =========