builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1460437873.41 results: success (0) buildid: 20160411214349 builduid: c7d90271083948a88824fe2cbcc8a74e revision: 7116915548728dd89dd80455daee47f1adff2e0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.411455) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.411860) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.412241) ========= 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=7de08804244eb36560b44971000001c3-1460437819.555109-1359500604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006379 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.435827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.436468) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.451511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.452205) ========= 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=7de08804244eb36560b44971000001c3-1460437819.555109-1359500604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.512407) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.512698) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.513077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.513353) ========= 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=7de08804244eb36560b44971000001c3-1460437819.555109-1359500604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-11 22:11:13-- 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.7M=0s 2016-04-11 22:11:13 (45.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172352 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.699846) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.700203) ========= 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=7de08804244eb36560b44971000001c3-1460437819.555109-1359500604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018500 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.757738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:13.758052) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7116915548728dd89dd80455daee47f1adff2e0c --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 7116915548728dd89dd80455daee47f1adff2e0c --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=7de08804244eb36560b44971000001c3-1460437819.555109-1359500604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-11 22:11:14,021 truncating revision to first 12 chars 2016-04-11 22:11:14,021 Setting DEBUG logging. 2016-04-11 22:11:14,021 attempt 1/10 2016-04-11 22:11:14,021 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/711691554872?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 22:11:14,319 unpacking tar archive at: fx-team-711691554872/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596393 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:14.367977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:14.368345) ========= echo 7116915548728dd89dd80455daee47f1adff2e0c in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7116915548728dd89dd80455daee47f1adff2e0c'] 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=7de08804244eb36560b44971000001c3-1460437819.555109-1359500604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7116915548728dd89dd80455daee47f1adff2e0c program finished with exit code 0 elapsedTime=0.003987 script_repo_revision: '7116915548728dd89dd80455daee47f1adff2e0c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:14.421169) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:14.421468) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 22:11:14.431316) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-11 22:11:14.431591) ========= /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=7de08804244eb36560b44971000001c3-1460437819.555109-1359500604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:11:14 INFO - MultiFileLogger online at 20160411 22:11:14 in /builds/slave/test 22:11:14 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 22:11:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:11:14 INFO - {'append_to_log': False, 22:11:14 INFO - 'base_work_dir': '/builds/slave/test', 22:11:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:11:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:11:14 INFO - 'branch': 'Fx-Team-Non-PGO', 22:11:14 INFO - 'buildbot_json_path': 'buildprops.json', 22:11:14 INFO - 'config_files': ('talos/linux_config.py',), 22:11:14 INFO - 'default_actions': ('clobber', 22:11:14 INFO - 'read-buildbot-config', 22:11:14 INFO - 'download-and-extract', 22:11:14 INFO - 'populate-webroot', 22:11:14 INFO - 'create-virtualenv', 22:11:14 INFO - 'install', 22:11:14 INFO - 'run-tests'), 22:11:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:11:14 INFO - 'download_minidump_stackwalk': True, 22:11:14 INFO - 'download_symbols': 'ondemand', 22:11:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:11:14 INFO - 'tooltool.py': '/tools/tooltool.py', 22:11:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:11:14 INFO - '/tools/misc-python/virtualenv.py')}, 22:11:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:11:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:11:14 INFO - 'installer_path': 'installer.exe', 22:11:14 INFO - 'log_level': 'info', 22:11:14 INFO - 'log_name': 'talos', 22:11:14 INFO - 'log_to_console': True, 22:11:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:11:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:11:14 INFO - 'opt_config_files': (), 22:11:14 INFO - 'pip_index': False, 22:11:14 INFO - 'sps_profile': False, 22:11:14 INFO - 'sps_profile_interval': 0, 22:11:14 INFO - 'suite': 'dromaeojs-e10s', 22:11:14 INFO - 'system_bits': '32', 22:11:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:11:14 INFO - 'title': 'talos-linux64-ix-003', 22:11:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:11:14 INFO - 'use_talos_json': True, 22:11:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:11:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:11:14 INFO - 'work_dir': 'build'} 22:11:14 INFO - ##### 22:11:14 INFO - ##### Running clobber step. 22:11:14 INFO - ##### 22:11:14 INFO - Running pre-action listener: _resource_record_pre_action 22:11:14 INFO - Running main action method: clobber 22:11:14 INFO - rmtree: /builds/slave/test/build 22:11:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:11:15 INFO - Running post-action listener: _resource_record_post_action 22:11:15 INFO - ##### 22:11:15 INFO - ##### Running read-buildbot-config step. 22:11:15 INFO - ##### 22:11:15 INFO - Running pre-action listener: _resource_record_pre_action 22:11:15 INFO - Running main action method: read_buildbot_config 22:11:15 INFO - Using buildbot properties: 22:11:15 INFO - { 22:11:15 INFO - "project": "", 22:11:15 INFO - "product": "firefox", 22:11:15 INFO - "script_repo_revision": "production", 22:11:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:11:15 INFO - "repository": "", 22:11:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:11:15 INFO - "buildid": "20160411214349", 22:11:15 INFO - "pgo_build": "False", 22:11:15 INFO - "basedir": "/builds/slave/test", 22:11:15 INFO - "buildnumber": 1388, 22:11:15 INFO - "slavename": "talos-linux64-ix-003", 22:11:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:11:15 INFO - "platform": "ubuntu64_hw", 22:11:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:11:15 INFO - "branch": "fx-team", 22:11:15 INFO - "repo_path": "integration/fx-team", 22:11:15 INFO - "revision": "7116915548728dd89dd80455daee47f1adff2e0c", 22:11:15 INFO - "stage_platform": "linux64", 22:11:15 INFO - "builduid": "c7d90271083948a88824fe2cbcc8a74e", 22:11:15 INFO - "slavebuilddir": "test" 22:11:15 INFO - } 22:11:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:11:15 INFO - Running post-action listener: _resource_record_post_action 22:11:15 INFO - ##### 22:11:15 INFO - ##### Running download-and-extract step. 22:11:15 INFO - ##### 22:11:15 INFO - Running pre-action listener: _resource_record_pre_action 22:11:15 INFO - Running main action method: download_and_extract 22:11:15 INFO - mkdir: /builds/slave/test/build/tests 22:11:15 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')]} 22:11:15 INFO - https://queue.taskcluster.net/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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 22:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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 22:11:27 INFO - Downloaded 1361 bytes. 22:11:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:11:27 INFO - Using the following test package requirements: 22:11:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:11:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:11:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:27 INFO - u'jsshell-linux-x86_64.zip'], 22:11:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:11:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:11:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:11:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:11:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:11:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:11:27 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')]} 22:11:27 INFO - https://queue.taskcluster.net/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:11:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:11:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:11:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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 22:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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 22:11:36 INFO - Downloaded 22190342 bytes. 22:11:36 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'] 22:11:36 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 22:11:37 INFO - Return code: 0 22:11:37 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 22:11: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')]} 22:11:37 INFO - https://queue.taskcluster.net/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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 22:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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 22:11:38 INFO - Downloaded 22190342 bytes. 22:11:38 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'] 22:11:38 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 22:11:39 INFO - Return code: 0 22:11:39 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')]} 22:11:39 INFO - https://queue.taskcluster.net/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:11:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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 22:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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 22:11:42 INFO - Downloaded 10841046 bytes. 22:11:42 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'] 22:11:42 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 22:11:42 INFO - Return code: 0 22:11:42 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')]} 22:11:42 INFO - https://queue.taskcluster.net/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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 22:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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 22:11:44 INFO - Downloaded 54122822 bytes. 22:11:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:11:44 INFO - mkdir: /builds/slave/test/properties 22:11:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:11:44 INFO - Writing to file /builds/slave/test/properties/build_url 22:11:44 INFO - Contents: 22:11:44 INFO - build_url:https://queue.taskcluster.net/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:11:44 INFO - Running post-action listener: _resource_record_post_action 22:11:44 INFO - Running post-action listener: set_extra_try_arguments 22:11:44 INFO - ##### 22:11:44 INFO - ##### Running populate-webroot step. 22:11:44 INFO - ##### 22:11:44 INFO - Running pre-action listener: _resource_record_pre_action 22:11:44 INFO - Running main action method: populate_webroot 22:11:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:11:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:11:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:11:44 INFO - '--tppagecycles', 22:11:44 INFO - '7'], 22:11:44 INFO - 'tests': ['tsvgm']}}, 22:11:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:11:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:11:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:11:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:11:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:11:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:11:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:44 INFO - 'talos_options': ['--disable-e10s'], 22:11:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:44 INFO - 'talos_options': ['--disable-e10s'], 22:11:44 INFO - 'tests': ['damp', 'tps']}, 22:11:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:44 INFO - 'tests': ['damp', 'tps']}, 22:11:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:11:44 INFO - 'tests': ['dromaeo_dom']}, 22:11:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:11:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:11:44 INFO - 'tests': ['a11yr', 22:11:44 INFO - 'ts_paint', 22:11:44 INFO - 'tpaint', 22:11:44 INFO - 'sessionrestore', 22:11:44 INFO - 'sessionrestore_no_auto_restore', 22:11:44 INFO - 'tabpaint']}, 22:11:44 INFO - 'other-e10s': {'tests': ['a11yr', 22:11:44 INFO - 'ts_paint', 22:11:44 INFO - 'tpaint', 22:11:44 INFO - 'sessionrestore', 22:11:44 INFO - 'sessionrestore_no_auto_restore', 22:11:44 INFO - 'tabpaint']}, 22:11:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:11:44 INFO - 'ts_paint', 22:11:44 INFO - 'tpaint', 22:11:44 INFO - 'sessionrestore', 22:11:44 INFO - 'sessionrestore_no_auto_restore', 22:11:44 INFO - 'tabpaint']}, 22:11:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:11:44 INFO - 'ts_paint', 22:11:44 INFO - 'tpaint', 22:11:44 INFO - 'sessionrestore', 22:11:44 INFO - 'sessionrestore_no_auto_restore', 22:11:44 INFO - 'tabpaint']}, 22:11:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:11:44 INFO - 'tests': ['a11yr', 22:11:44 INFO - 'ts_paint', 22:11:44 INFO - 'tpaint', 22:11:44 INFO - 'sessionrestore', 22:11:44 INFO - 'sessionrestore_no_auto_restore', 22:11:44 INFO - 'tabpaint']}, 22:11:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:11:44 INFO - 'tests': ['a11yr', 22:11:44 INFO - 'ts_paint', 22:11:44 INFO - 'tpaint', 22:11:44 INFO - 'sessionrestore', 22:11:44 INFO - 'sessionrestore_no_auto_restore', 22:11:44 INFO - 'tabpaint']}, 22:11:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:11:44 INFO - 'tests': ['tsvgx', 22:11:44 INFO - 'tsvgr_opacity', 22:11:44 INFO - 'tart', 22:11:44 INFO - 'tscrollx', 22:11:44 INFO - 'cart']}, 22:11:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:11:44 INFO - 'tsvgr_opacity', 22:11:44 INFO - 'tart', 22:11:44 INFO - 'tscrollx', 22:11:44 INFO - 'cart']}, 22:11:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:44 INFO - 'talos_options': ['--disable-e10s'], 22:11:44 INFO - 'tests': ['tp5o']}, 22:11:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:44 INFO - 'tests': ['tp5o']}, 22:11:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:44 INFO - 'talos_options': ['--disable-e10s', 22:11:44 INFO - '--xperf_path', 22:11:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:44 INFO - 'tests': ['tp5n']}, 22:11:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:44 INFO - 'talos_options': ['--xperf_path', 22:11:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:44 INFO - 'tests': ['tp5n']}}, 22:11:44 INFO - 'talos.zip': {'path': '', 22:11:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:11:44 INFO - Running post-action listener: _resource_record_post_action 22:11:44 INFO - ##### 22:11:44 INFO - ##### Running create-virtualenv step. 22:11:44 INFO - ##### 22:11:44 INFO - Running pre-action listener: _resource_record_pre_action 22:11:44 INFO - Running main action method: create_virtualenv 22:11:44 INFO - Creating virtualenv /builds/slave/test/build/venv 22:11:44 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 22:11:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:11:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:11:44 INFO - Using real prefix '/usr' 22:11:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:11:45 INFO - Installing distribute.............................................................................................................................................................................................done. 22:11:47 INFO - Installing pip.................done. 22:11:47 INFO - Return code: 0 22:11:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:11:47 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')]} 22:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:47 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')]} 22:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:47 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 0x7fe923451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', '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 22:11:47 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 22:11:47 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 22:11:47 INFO - Using env: {'DISPLAY': ':0', 22:11:47 INFO - 'HOME': '/home/cltbld', 22:11:47 INFO - 'LANG': 'en_US.UTF-8', 22:11:47 INFO - 'LANGUAGE': 'en_US:en', 22:11:47 INFO - 'LOGNAME': 'cltbld', 22:11:47 INFO - 'MAIL': '/var/mail/cltbld', 22:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:47 INFO - 'MOZ_NO_REMOTE': '1', 22:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:47 INFO - 'NO_EM_RESTART': '1', 22:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:47 INFO - 'PWD': '/builds/slave/test', 22:11:47 INFO - 'SHELL': '/bin/bash', 22:11:47 INFO - 'SHLVL': '1', 22:11:47 INFO - 'TERM': 'linux', 22:11:47 INFO - 'TMOUT': '86400', 22:11:47 INFO - 'USER': 'cltbld', 22:11:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', 22:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:47 INFO - '_': '/tools/buildbot/bin/python'} 22:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:47 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 22:11:47 INFO - Cleaning up... 22:11:47 INFO - Return code: 0 22:11:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:11:47 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')]} 22:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:47 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')]} 22:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:47 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 0x7fe923451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', '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 22:11:47 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 22:11:47 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 22:11:47 INFO - Using env: {'DISPLAY': ':0', 22:11:47 INFO - 'HOME': '/home/cltbld', 22:11:47 INFO - 'LANG': 'en_US.UTF-8', 22:11:47 INFO - 'LANGUAGE': 'en_US:en', 22:11:47 INFO - 'LOGNAME': 'cltbld', 22:11:47 INFO - 'MAIL': '/var/mail/cltbld', 22:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:47 INFO - 'MOZ_NO_REMOTE': '1', 22:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:47 INFO - 'NO_EM_RESTART': '1', 22:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:47 INFO - 'PWD': '/builds/slave/test', 22:11:47 INFO - 'SHELL': '/bin/bash', 22:11:47 INFO - 'SHLVL': '1', 22:11:47 INFO - 'TERM': 'linux', 22:11:47 INFO - 'TMOUT': '86400', 22:11:47 INFO - 'USER': 'cltbld', 22:11:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', 22:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:47 INFO - '_': '/tools/buildbot/bin/python'} 22:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:47 INFO - Downloading/unpacking psutil>=0.7.1 22:11:47 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 22:11:47 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 22:11:47 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 22:11:47 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 22:11:47 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 22:11:47 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 22:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:11:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:49 INFO - Installing collected packages: psutil 22:11:49 INFO - Running setup.py install for psutil 22:11:49 INFO - building 'psutil._psutil_linux' extension 22:11:49 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 22:11:50 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 22:11:50 INFO - building 'psutil._psutil_posix' extension 22:11:50 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 22:11:50 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 22:11:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:50 INFO - Successfully installed psutil 22:11:50 INFO - Cleaning up... 22:11:50 INFO - Return code: 0 22:11:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:11: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')]} 22:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11: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')]} 22:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11: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', '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 0x7fe923451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', '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 22:11: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:11: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 mozsystemmonitor==0.0.0 22:11:50 INFO - Using env: {'DISPLAY': ':0', 22:11:50 INFO - 'HOME': '/home/cltbld', 22:11:50 INFO - 'LANG': 'en_US.UTF-8', 22:11:50 INFO - 'LANGUAGE': 'en_US:en', 22:11:50 INFO - 'LOGNAME': 'cltbld', 22:11:50 INFO - 'MAIL': '/var/mail/cltbld', 22:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:50 INFO - 'MOZ_NO_REMOTE': '1', 22:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:50 INFO - 'NO_EM_RESTART': '1', 22:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:50 INFO - 'PWD': '/builds/slave/test', 22:11:50 INFO - 'SHELL': '/bin/bash', 22:11:50 INFO - 'SHLVL': '1', 22:11:50 INFO - 'TERM': 'linux', 22:11:50 INFO - 'TMOUT': '86400', 22:11:50 INFO - 'USER': 'cltbld', 22:11:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', 22:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:50 INFO - '_': '/tools/buildbot/bin/python'} 22:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:11:52 INFO - Installing collected packages: mozsystemmonitor 22:11:52 INFO - Running setup.py install for mozsystemmonitor 22:11:52 INFO - Successfully installed mozsystemmonitor 22:11:52 INFO - Cleaning up... 22:11:52 INFO - Return code: 0 22:11:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:52 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 0x7fe923451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', '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 22:11:52 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 22:11:52 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 22:11:52 INFO - Using env: {'DISPLAY': ':0', 22:11:52 INFO - 'HOME': '/home/cltbld', 22:11:52 INFO - 'LANG': 'en_US.UTF-8', 22:11:52 INFO - 'LANGUAGE': 'en_US:en', 22:11:52 INFO - 'LOGNAME': 'cltbld', 22:11:52 INFO - 'MAIL': '/var/mail/cltbld', 22:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:52 INFO - 'MOZ_NO_REMOTE': '1', 22:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:52 INFO - 'NO_EM_RESTART': '1', 22:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:52 INFO - 'PWD': '/builds/slave/test', 22:11:52 INFO - 'SHELL': '/bin/bash', 22:11:52 INFO - 'SHLVL': '1', 22:11:52 INFO - 'TERM': 'linux', 22:11:52 INFO - 'TMOUT': '86400', 22:11:52 INFO - 'USER': 'cltbld', 22:11:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', 22:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:52 INFO - '_': '/tools/buildbot/bin/python'} 22:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:11:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:11:54 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 22:11:54 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 22:11:54 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 22:11:54 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 22:11:54 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 22:11:54 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 22:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:11:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11:55 INFO - Downloading docopt-0.6.1.tar.gz 22:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:11:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:11:55 INFO - Running setup.py install for blobuploader 22:11:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:11:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:11:55 INFO - Running setup.py install for requests 22:11:56 INFO - Running setup.py install for docopt 22:11:56 INFO - Successfully installed blobuploader requests docopt 22:11:56 INFO - Cleaning up... 22:11:56 INFO - Return code: 0 22:11:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11:56 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')]} 22:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:56 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')]} 22:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:56 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 0x7fe923451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', '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 22:11:56 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 22:11:56 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 22:11:56 INFO - Using env: {'DISPLAY': ':0', 22:11:56 INFO - 'HOME': '/home/cltbld', 22:11:56 INFO - 'LANG': 'en_US.UTF-8', 22:11:56 INFO - 'LANGUAGE': 'en_US:en', 22:11:56 INFO - 'LOGNAME': 'cltbld', 22:11:56 INFO - 'MAIL': '/var/mail/cltbld', 22:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:56 INFO - 'MOZ_NO_REMOTE': '1', 22:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:56 INFO - 'NO_EM_RESTART': '1', 22:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:56 INFO - 'PWD': '/builds/slave/test', 22:11:56 INFO - 'SHELL': '/bin/bash', 22:11:56 INFO - 'SHLVL': '1', 22:11:56 INFO - 'TERM': 'linux', 22:11:56 INFO - 'TMOUT': '86400', 22:11:56 INFO - 'USER': 'cltbld', 22:11:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', 22:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:56 INFO - '_': '/tools/buildbot/bin/python'} 22:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:11:56 INFO - Running setup.py (path:/tmp/pip-thu_qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:11:56 INFO - Running setup.py (path:/tmp/pip-phRuet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:11:56 INFO - Running setup.py (path:/tmp/pip-g9UszN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:11:56 INFO - Running setup.py (path:/tmp/pip-Chpnw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:11:56 INFO - Running setup.py (path:/tmp/pip-_5ZNxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:11:56 INFO - Running setup.py (path:/tmp/pip-Q4JEOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:11:56 INFO - Running setup.py (path:/tmp/pip-4dxs6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:11:56 INFO - Running setup.py (path:/tmp/pip-vnzjCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:11:56 INFO - Running setup.py (path:/tmp/pip-qlfurT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:11:57 INFO - Running setup.py (path:/tmp/pip-_5gonM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:11:57 INFO - Running setup.py (path:/tmp/pip-8vfZPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:11:57 INFO - Running setup.py (path:/tmp/pip-I9ZQe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:11:57 INFO - Running setup.py (path:/tmp/pip-4c3rSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:11:57 INFO - Running setup.py (path:/tmp/pip-KLgCnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:57 INFO - Running setup.py (path:/tmp/pip-Kw_aPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:11:57 INFO - Running setup.py (path:/tmp/pip-cAn4Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:11:57 INFO - Running setup.py (path:/tmp/pip-n9EsrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:11:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:11:57 INFO - Running setup.py install for manifestparser 22:11:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:11:57 INFO - Running setup.py install for mozcrash 22:11:57 INFO - Running setup.py install for mozdebug 22:11:57 INFO - Running setup.py install for mozdevice 22:11:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Running setup.py install for mozfile 22:11:58 INFO - Running setup.py install for mozhttpd 22:11:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Running setup.py install for mozinfo 22:11:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Running setup.py install for mozInstall 22:11:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Running setup.py install for mozleak 22:11:58 INFO - Running setup.py install for mozlog 22:11:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Running setup.py install for moznetwork 22:11:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Running setup.py install for mozprocess 22:11:58 INFO - Running setup.py install for mozprofile 22:11:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:11:58 INFO - Running setup.py install for mozrunner 22:11:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:11:59 INFO - Running setup.py install for mozscreenshot 22:11:59 INFO - Running setup.py install for moztest 22:11:59 INFO - Running setup.py install for mozversion 22:11:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:11:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:11:59 INFO - Cleaning up... 22:11:59 INFO - Return code: 0 22:11:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:11:59 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')]} 22:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:59 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')]} 22:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:59 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 0x7fe923451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', '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 22:11:59 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 22:11:59 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 22:11:59 INFO - Using env: {'DISPLAY': ':0', 22:11:59 INFO - 'HOME': '/home/cltbld', 22:11:59 INFO - 'LANG': 'en_US.UTF-8', 22:11:59 INFO - 'LANGUAGE': 'en_US:en', 22:11:59 INFO - 'LOGNAME': 'cltbld', 22:11:59 INFO - 'MAIL': '/var/mail/cltbld', 22:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:59 INFO - 'MOZ_NO_REMOTE': '1', 22:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:59 INFO - 'NO_EM_RESTART': '1', 22:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:59 INFO - 'PWD': '/builds/slave/test', 22:11:59 INFO - 'SHELL': '/bin/bash', 22:11:59 INFO - 'SHLVL': '1', 22:11:59 INFO - 'TERM': 'linux', 22:11:59 INFO - 'TMOUT': '86400', 22:11:59 INFO - 'USER': 'cltbld', 22:11:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', 22:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:59 INFO - '_': '/tools/buildbot/bin/python'} 22:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:11:59 INFO - Running setup.py (path:/tmp/pip-P4Gdjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:11:59 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)) 22:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:11:59 INFO - Running setup.py (path:/tmp/pip-_JW8zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:11:59 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)) 22:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:11:59 INFO - Running setup.py (path:/tmp/pip-AKUKqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:11:59 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)) 22:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:11:59 INFO - Running setup.py (path:/tmp/pip-V3N73c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:11:59 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)) 22:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:11:59 INFO - Running setup.py (path:/tmp/pip-slvj7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:11:59 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)) 22:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:12:00 INFO - Running setup.py (path:/tmp/pip-koMjFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:12:00 INFO - Running setup.py (path:/tmp/pip-0vAElL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:12:00 INFO - Running setup.py (path:/tmp/pip-ANgYAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:12:00 INFO - Running setup.py (path:/tmp/pip-Pv4v6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:12:00 INFO - Running setup.py (path:/tmp/pip-fEfzD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:12:00 INFO - Running setup.py (path:/tmp/pip-jY1q8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:12:00 INFO - Running setup.py (path:/tmp/pip-1TOyXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:12:00 INFO - Running setup.py (path:/tmp/pip-7iKWqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:12:00 INFO - Running setup.py (path:/tmp/pip-jao9zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:00 INFO - Running setup.py (path:/tmp/pip-UXtezB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:12:00 INFO - Running setup.py (path:/tmp/pip-mcNezB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:12:00 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)) 22:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:12:00 INFO - Running setup.py (path:/tmp/pip-sOrJGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:12:00 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)) 22:12:00 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)) 22:12:00 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)) 22:12:00 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)) 22:12:00 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)) 22:12:00 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)) 22:12:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:02 INFO - Downloading blessings-1.6.tar.gz 22:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:12:02 INFO - Installing collected packages: blessings 22:12:02 INFO - Running setup.py install for blessings 22:12:02 INFO - Successfully installed blessings 22:12:02 INFO - Cleaning up... 22:12:03 INFO - Return code: 0 22:12:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:12:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:12:03 INFO - Reading from file tmpfile_stdout 22:12:03 INFO - Current package versions: 22:12:03 INFO - argparse == 1.2.1 22:12:03 INFO - blessings == 1.6 22:12:03 INFO - blobuploader == 1.2.4 22:12:03 INFO - docopt == 0.6.1 22:12:03 INFO - manifestparser == 1.1 22:12:03 INFO - mozInstall == 1.12 22:12:03 INFO - mozcrash == 0.17 22:12:03 INFO - mozdebug == 0.1 22:12:03 INFO - mozdevice == 0.48 22:12:03 INFO - mozfile == 1.2 22:12:03 INFO - mozhttpd == 0.7 22:12:03 INFO - mozinfo == 0.9 22:12:03 INFO - mozleak == 0.1 22:12:03 INFO - mozlog == 3.1 22:12:03 INFO - moznetwork == 0.27 22:12:03 INFO - mozprocess == 0.22 22:12:03 INFO - mozprofile == 0.28 22:12:03 INFO - mozrunner == 6.11 22:12:03 INFO - mozscreenshot == 0.1 22:12:03 INFO - mozsystemmonitor == 0.0 22:12:03 INFO - moztest == 0.7 22:12:03 INFO - mozversion == 1.4 22:12:03 INFO - psutil == 3.1.1 22:12:03 INFO - requests == 1.2.3 22:12:03 INFO - wsgiref == 0.1.2 22:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:12:03 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')]} 22:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:03 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')]} 22:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:03 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 0x7fe923451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', '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 22:12:03 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 22:12:03 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 22:12:03 INFO - Using env: {'DISPLAY': ':0', 22:12:03 INFO - 'HOME': '/home/cltbld', 22:12:03 INFO - 'LANG': 'en_US.UTF-8', 22:12:03 INFO - 'LANGUAGE': 'en_US:en', 22:12:03 INFO - 'LOGNAME': 'cltbld', 22:12:03 INFO - 'MAIL': '/var/mail/cltbld', 22:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:03 INFO - 'MOZ_NO_REMOTE': '1', 22:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:03 INFO - 'NO_EM_RESTART': '1', 22:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:03 INFO - 'PWD': '/builds/slave/test', 22:12:03 INFO - 'SHELL': '/bin/bash', 22:12:03 INFO - 'SHLVL': '1', 22:12:03 INFO - 'TERM': 'linux', 22:12:03 INFO - 'TMOUT': '86400', 22:12:03 INFO - 'USER': 'cltbld', 22:12:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', 22:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:03 INFO - '_': '/tools/buildbot/bin/python'} 22:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:03 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)) 22:12:03 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)) 22:12:03 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)) 22:12:03 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)) 22:12:03 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)) 22:12:03 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)) 22:12:03 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)) 22:12:03 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)) 22:12:03 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)) 22:12:03 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)) 22:12:03 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)) 22:12:03 INFO - Cleaning up... 22:12:03 INFO - Return code: 0 22:12:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:12:03 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')]} 22:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:03 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')]} 22:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:03 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 0x7fe923451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', '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 22:12:03 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 22:12:03 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 22:12:03 INFO - Using env: {'DISPLAY': ':0', 22:12:03 INFO - 'HOME': '/home/cltbld', 22:12:03 INFO - 'LANG': 'en_US.UTF-8', 22:12:03 INFO - 'LANGUAGE': 'en_US:en', 22:12:03 INFO - 'LOGNAME': 'cltbld', 22:12:03 INFO - 'MAIL': '/var/mail/cltbld', 22:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:03 INFO - 'MOZ_NO_REMOTE': '1', 22:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:03 INFO - 'NO_EM_RESTART': '1', 22:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:03 INFO - 'PWD': '/builds/slave/test', 22:12:03 INFO - 'SHELL': '/bin/bash', 22:12:03 INFO - 'SHLVL': '1', 22:12:03 INFO - 'TERM': 'linux', 22:12:03 INFO - 'TMOUT': '86400', 22:12:03 INFO - 'USER': 'cltbld', 22:12:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', 22:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:03 INFO - '_': '/tools/buildbot/bin/python'} 22:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:03 INFO - Downloading/unpacking jsonschema 22:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:12:05 INFO - Downloading/unpacking functools32 (from jsonschema) 22:12:05 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 22:12:05 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 22:12:05 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 22:12:05 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 22:12:05 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 22:12:05 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 22:12:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:12:05 INFO - warning: no files found matching '*.txt' 22:12:05 INFO - no previously-included directories found matching 'build' 22:12:05 INFO - no previously-included directories found matching 'dist' 22:12:05 INFO - no previously-included directories found matching '.git*' 22:12:05 INFO - Installing collected packages: jsonschema, functools32 22:12:05 INFO - Running setup.py install for functools32 22:12:05 INFO - warning: no files found matching '*.txt' 22:12:05 INFO - no previously-included directories found matching 'build' 22:12:05 INFO - no previously-included directories found matching 'dist' 22:12:05 INFO - no previously-included directories found matching '.git*' 22:12:05 INFO - Successfully installed jsonschema functools32 22:12:05 INFO - Cleaning up... 22:12:05 INFO - Return code: 0 22:12:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:12:05 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')]} 22:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:05 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')]} 22:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:05 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 0x7fe923451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, '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': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', '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 22:12:05 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 22:12:05 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 22:12:05 INFO - Using env: {'DISPLAY': ':0', 22:12:06 INFO - 'HOME': '/home/cltbld', 22:12:06 INFO - 'LANG': 'en_US.UTF-8', 22:12:06 INFO - 'LANGUAGE': 'en_US:en', 22:12:06 INFO - 'LOGNAME': 'cltbld', 22:12:06 INFO - 'MAIL': '/var/mail/cltbld', 22:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:06 INFO - 'MOZ_NO_REMOTE': '1', 22:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:06 INFO - 'NO_EM_RESTART': '1', 22:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:06 INFO - 'PWD': '/builds/slave/test', 22:12:06 INFO - 'SHELL': '/bin/bash', 22:12:06 INFO - 'SHLVL': '1', 22:12:06 INFO - 'TERM': 'linux', 22:12:06 INFO - 'TMOUT': '86400', 22:12:06 INFO - 'USER': 'cltbld', 22:12:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', 22:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:06 INFO - '_': '/tools/buildbot/bin/python'} 22:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:06 INFO - Downloading/unpacking flake8 22:12:06 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 22:12:06 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 22:12:06 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 22:12:06 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 22:12:06 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 22:12:06 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 22:12:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:12:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:12:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:12:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:12:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:12:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:12:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:12:08 INFO - no previously-included directories found matching 'docs/_build' 22:12:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:12:08 INFO - Running setup.py install for pep8 22:12:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:12:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:12:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:12:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:12:08 INFO - no previously-included directories found matching 'docs/_build' 22:12:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:12:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:12:08 INFO - Cleaning up... 22:12:09 INFO - Return code: 0 22:12:09 INFO - Running post-action listener: _resource_record_post_action 22:12:09 INFO - Running post-action listener: _start_resource_monitoring 22:12:09 INFO - Starting resource monitoring. 22:12:09 INFO - ##### 22:12:09 INFO - ##### Running install step. 22:12:09 INFO - ##### 22:12:09 INFO - Running pre-action listener: _resource_record_pre_action 22:12:09 INFO - Running main action method: install 22:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:12:09 INFO - Reading from file tmpfile_stdout 22:12:09 INFO - Detecting whether we're running mozinstall >=1.0... 22:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:12:09 INFO - Reading from file tmpfile_stdout 22:12:09 INFO - Output received: 22:12:09 INFO - Usage: mozinstall [options] installer 22:12:09 INFO - Options: 22:12:09 INFO - -h, --help show this help message and exit 22:12:09 INFO - -d DEST, --destination=DEST 22:12:09 INFO - Directory to install application into. [default: 22:12:09 INFO - "/builds/slave/test"] 22:12:09 INFO - --app=APP Application being installed. [default: firefox] 22:12:09 INFO - mkdir: /builds/slave/test/build/application 22:12:09 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'] 22:12:09 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 22:12:24 INFO - Reading from file tmpfile_stdout 22:12:24 INFO - Output received: 22:12:24 INFO - /builds/slave/test/build/application/firefox/firefox 22:12:24 INFO - Running post-action listener: _resource_record_post_action 22:12:24 INFO - ##### 22:12:24 INFO - ##### Running run-tests step. 22:12:24 INFO - ##### 22:12:24 INFO - Running pre-action listener: _resource_record_pre_action 22:12:24 INFO - Running main action method: run_tests 22:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:12:25 INFO - Python 2.7.3 22:12:25 INFO - Return code: 0 22:12:25 INFO - grabbing minidump binary from tooltool 22:12: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')]} 22:12:25 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 0x1a77410>, '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 0x1a78310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a787a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:12:25 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 22:12:25 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 22:12:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:12:25 INFO - Return code: 0 22:12:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:12:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:12:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:12:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:12:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:12:26 INFO - Return code: 0 22:12:26 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/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 22:12:26 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/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 22:12:26 INFO - Using env: {'DISPLAY': ':0', 22:12:26 INFO - 'HOME': '/home/cltbld', 22:12:26 INFO - 'LANG': 'en_US.UTF-8', 22:12:26 INFO - 'LANGUAGE': 'en_US:en', 22:12:26 INFO - 'LOGNAME': 'cltbld', 22:12:26 INFO - 'MAIL': '/var/mail/cltbld', 22:12:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:12:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:26 INFO - 'MOZ_NO_REMOTE': '1', 22:12:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:26 INFO - 'NO_EM_RESTART': '1', 22:12:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:26 INFO - 'PWD': '/builds/slave/test', 22:12:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:12:26 INFO - 'SHELL': '/bin/bash', 22:12:26 INFO - 'SHLVL': '1', 22:12:26 INFO - 'TERM': 'linux', 22:12:26 INFO - 'TMOUT': '86400', 22:12:26 INFO - 'USER': 'cltbld', 22:12:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460437819.555109-1359500604', 22:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:26 INFO - '_': '/tools/buildbot/bin/python'} 22:12:26 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/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 22:12:26 INFO - mozversion application_buildid: 20160411214349 22:12:26 INFO - mozversion application_changeset: 7116915548728dd89dd80455daee47f1adff2e0c 22:12:26 INFO - mozversion application_display_name: Nightly 22:12:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:12:26 INFO - mozversion application_name: Firefox 22:12:26 INFO - mozversion application_remotingname: firefox 22:12:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:12:26 INFO - mozversion application_vendor: Mozilla 22:12:26 INFO - mozversion application_version: 48.0a1 22:12:26 INFO - mozversion platform_buildid: 20160411214349 22:12:26 INFO - mozversion platform_changeset: 7116915548728dd89dd80455daee47f1adff2e0c 22:12:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:12:26 INFO - mozversion platform_version: 48.0a1 22:12:26 INFO - using testdate: 1460437946 22:12:26 INFO - actual date: 1460437946 22:12:26 INFO - starting webserver on 'localhost:36414' 22:12:26 INFO - SUITE-START | Running 2 tests 22:12:26 INFO - TEST-START | dromaeo_css 22:12:26 INFO - operating with platform_type : linux_ 22:12:26 INFO - Initialising browser for dromaeo_css test... 22:12:26 INFO - TEST-INFO | started process 22485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP1x2BK/profile http://localhost:36414/getInfo.html) 22:12:30 INFO - PROCESS | 22485 | 22:12:30 INFO - PROCESS | 22485 | (process:22553): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:12:30 INFO - PROCESS | 22485 | 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] 22:12:31 INFO - PROCESS | 22485 | __metrics Screen width/height:1600/1200 22:12:31 INFO - PROCESS | 22485 | colorDepth:24 22:12:31 INFO - PROCESS | 22485 | Browser inner width/height: 1024/697 22:12:31 INFO - PROCESS | 22485 | __metrics 22:12:32 ERROR - PROCESS | 22485 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 22:12:33 INFO - TEST-INFO | 22485: exit 0 22:12:33 INFO - Browser initialized. 22:12:33 INFO - Running cycle 1/1 for dromaeo_css test... 22:12:33 INFO - TEST-INFO | started process 22603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP1x2BK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:12:35 INFO - PROCESS | 22603 | 22:12:35 INFO - PROCESS | 22603 | (process:22662): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:12:45 INFO - PROCESS | 22603 | RSS: Main: 164679680 22:12:45 INFO - PROCESS | 22603 | 22:13:34 INFO - PROCESS | 22603 | 1460438014824 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] 22:15:46 INFO - PROCESS | 22603 | Cycle 1(1): loaded http://localhost:36414/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36414/tests/dromaeo/cssquery-ext.html) 22:15:47 INFO - PROCESS | 22603 | RSS: Main: 168636416 22:15:47 INFO - PROCESS | 22603 | 22:18:49 INFO - PROCESS | 22603 | Cycle 1(1): loaded http://localhost:36414/tests/dromaeo/cssquery-ext.html (next: http://localhost:36414/tests/dromaeo/cssquery-jquery.html) 22:18:50 INFO - PROCESS | 22603 | RSS: Main: 165126144 22:18:50 INFO - PROCESS | 22603 | 22:21:52 INFO - PROCESS | 22603 | Cycle 1(1): loaded http://localhost:36414/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36414/tests/dromaeo/cssquery-mootools.html) 22:21:52 INFO - PROCESS | 22603 | RSS: Main: 166555648 22:21:52 INFO - PROCESS | 22603 | 22:24:54 INFO - PROCESS | 22603 | Cycle 1(1): loaded http://localhost:36414/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36414/tests/dromaeo/cssquery-prototype.html) 22:24:55 INFO - PROCESS | 22603 | RSS: Main: 164311040 22:24:55 INFO - PROCESS | 22603 | 22:27:57 INFO - PROCESS | 22603 | Cycle 1(1): loaded http://localhost:36414/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36414/tests/dromaeo/cssquery-yui.html) 22:27:58 INFO - PROCESS | 22603 | RSS: Main: 165421056 22:27:58 INFO - PROCESS | 22603 | 22:31:00 INFO - PROCESS | 22603 | Cycle 1(1): loaded http://localhost:36414/tests/dromaeo/cssquery-yui.html (next: http://localhost:36414/tests/dromaeo/cssquery-dojo.html) 22:31:01 INFO - PROCESS | 22603 | RSS: Main: 167829504 22:31:01 INFO - PROCESS | 22603 | 22:31:01 INFO - PROCESS | 22603 | __start_tp_report 22:31:01 INFO - PROCESS | 22603 | _x_x_mozilla_page_load 22:31:01 INFO - PROCESS | 22603 | _x_x_mozilla_page_load_details 22:31:01 INFO - PROCESS | 22603 | |i|pagename|runs| 22:31:01 INFO - PROCESS | 22603 | |0;dojo.html;2619.777318927891;2692.3807524269428;2693.2458911504787;2720.143154906206;2722.74133957274;4586.793594288257;4601.102784956931;4601.907961840761;4626.560476754707;4674.976625116869;4616.953830461694;4652.999999999992;4681.976590117053;4734.455537613176;4743.146233677937;4317.33081372387;4345.174416860787;4381.123775244948;4402.471703395597;4409.735415875041;531.2921553745318;4317.76252306123;4367.672424568154;4375.212461756899;4450.421445212134;4395.230834603964;4395.450568678915;4398.34024896265;4398.626116780078;4441.555844415565;4226.281532139544;4459.0413061192;4476.932846007313;4477.977610111961;4518.457785065781;4252.808623611945;4282.464691913511;4310.80601372939;4315.3742707307265;4326.199653064194;4600.907981840378;4623.052274283764;4624.953750462486;4689.038747056845;4729.006908549209;4947.802087916479;5003.924941125886;5040.924386134211;5059.418166910778;5072.137736584789;5121.871953201163;5128.282040514331;5129.794808207667;5145.434002259786;5156.587473002151;4739.928901066487;4782.832600858988;4786.712797232177;4792.329073929653;4837.0567739290855;5088.872778180576;5211.088059589557;5270;5305.734713264322;5317.54800841925;4999.375078115236;5004.449510553836;5007.298978143063;5011.674241174312;5075.593952483792;5079.517445842639;5097.668651537638;5101.336826212643;5114.335136432314;5120.283160357553;4869.245266983623;4981.352424184905;5029.346184996;5049.394072711299;5089.185730283211;4877.902441951142;4984.077945580007;5001.64988450805;5021;5070.847874563769;4315.331123675835;4342.174986752507;4345.826166953287;4381.277089280296;4381.605655491021;3713.4801127842125;3772.9434058489146;3794.880510249483;3812.3900175972267;3830.8659196927974;4347.282698354799;4362.062156636339;4373.2565463871215;4395.538468460765;4409.977950110229;5027.79888804451;5033.748312584356;5034.967831594514;5054.4692807254705;5104.3109180260935;4357.54245804186;4361.193179261783;4372.672049596293;4401.735895846259;4407.118576284692;4525.208088584484;4553.795079221377;4572.862814115582;4591.403117594691;4609.861704148881;4739.360186374795;4773.64197685175;4790.880227994258;4810.687305325143;4813.638977076804;4945.184044632595;4997.725125118153;4998.225275082368;5030.572401345927;5036.949630503648;4743.501932297059;4746.050789842115;4760.119377914958;4772.331873537638;4806.807727690853;4835.685680430761;4946.703197808143;4994.101061808764;5034.119029169808;5073.315102461121;5036.798528058983;5043.2435134730085;5065.645404821627;5077;5122.74386280677;4894.559489645949;4915.5330243626795;4918.360613120414;4922.803087876445;4976.427710813303;4812.687175333592;4903.460619331942;4914.901701966012;4952.4304704959395;4990.6007519397635;4698.976505117589;4820.493848145894;4820.734859582757;4825.9034819302715;4900.166971614763;4940.036692845005;4968.801247950186;4977.626677999092;4980.128477516492;5027.396712394536;4652.55800698933;4831.154547954165;4872.756362181947;4889.682170658896;4917.237828136645 22:31:01 INFO - PROCESS | 22603 | |1;ext.html;571.191763654429;599.1342510072946;607.0560278766517;614.6527212125147;629.44608744305;30341.544876826836;31060.22349441265;31187.220319492026;31298.217544561398;31305.373892522137;35575;36013.279734405296;36131.09672258188;36218;36299.818500907524;7429.739959101446;7547.018887544611;7556.546607203558;7597.810054748647;7611.2388761124;7513.887291690629;7776.961115194416;7787.143414224459;7798.181190974951;7798.80502987427;7536.623168841536;7606.3914886808925;7631.427642926775;7633.732819351324;7642.082950046002;7704.0755109386955;7743.845123097534;7803;7818.37453003764;7821.530708157472;7674.347680447168;7723.53658780475;7727.536347819148;7744.225577442267;7758.185390533969;29415.558766618517;34761.478577821355;35158.472622910675;35202.29595408077;35246.823765881265;2883.336832528509;2940.491007452883;2952.409518096389;2975.851207439641;3025.9243518911985;27142;28196.85901570479;28495.715042849515;28743.28141796451;29123.708762912313;3151.322465669869;3175.6506784253716;3190.5054716518976;3209.3902158589794;3253.9186520336943;318360;327968;328434;329516;329561;35445.64554354475;36282.8185859069;36509.08727281786;58995;59698.70150649219;35806;35948.82025589855;36003.279934401166;36068.639313607055;36136.457953130724;13110.934445327712;13348.93325533366;13356.398962046536;13361.732765344834;13377.598672039854;10278.074973252444;10283.280170388001;10300.278980471445;10324.741881452874;10369.844452333222;8200.097989221182;8253.463524870864;8293.875591866126;8320.334373250125;8338.916610833936;3258.8859389921713;3263.1352691536763;3268.591426071741;3300.3564304960782;3321.501774733761;899.392909785905;908.68650315641;950.2825366848124;990.6582229130938;993.7465946183821;27087;28709.712902870702;28782.42435151285;29015.12954611365;29308.413831723246;1000.8348622477355;1012.3976234140674;1017.2574020964737;1029.1869423155772;1039.262123892045;14909.776353354708;15437.768433473508;15439.30523126462;15461.922690386476;15709.135997520018;334668;342475;343876;344403;344499;47132.7643361781;48004.279935800994;48080.27879581809;48096.27855582169;48122.518774811804;1215.769003889258;1229.1211783574608;1242.8384310039637;1259.9748005039849;1275.3113318807739;26770.330741730835;27649.58525622077;27705.72294277112;27982;28634.14097577076;44055.33916991312;44273.33589996088;44711.32933005942;44723.32915006342;44774.3283850736;311423;314358;318590;318790;319630;25553.48893022166;25876.48247035011;25998;26082.86958565271;26189.607155893056;41488;42003;42192;42571.787141064095;42943.57056429521;36602.45096323504;36918.81540592387;37079.443808343436;37486.812565937;37709.434358485196;35493;36042.45936310905;36252.4562131563;36490.45264320984;37405;35896.64103359037;36217;36430.4535431974;36511;36661.45007824938;30886.073417797503;32379.51430728588;32684.436458021934;32846.835765821015;32980.83509582437;24856;25144.37139071538;25278.873605631856;25471.61792573076;25539.36151596225 22:31:01 INFO - PROCESS | 22603 | |2;jquery.html;363.48566778009115;363.72357008673407;376.7419317767331;384.09162331086986;390.9882703518895;15598.142102184376;16544.91727541362;17403.390881319156;17606.559836004108;17629.20668569914;15746.212689365515;16154.111523866211;16802.579935501617;16907.49277521673;16990.320387184496;5058.215976523636;5183.844484665466;5190.06578815813;5226.346706661668;5229.764660590283;3712.1647629283466;5102.1836506159025;5716.742746576414;6067.423594758513;6075.544334174932;5951.464368206861;5978.8804223915495;5984.311804142514;5991.580589358747;6010.969945150268;4884;5200.531952124308;5205.219217117444;5208.2968799212;5209.426963034063;4536.637069034469;4854.902901941977;4855;5034.974825125888;5042.294078828967;11857.229280096766;11960.102992275613;12098.455569499394;13132.934335328358;20177.19291228349;1818.5726354306728;1850.501094113772;2038.98980505098;2105.95788084239;2265.9576594766427;8516.318694504487;9213.447193168431;9341.39280946743;9363.110504502061;9494.715158545254;1707.9402220922332;1709.5127888551826;1735.9132043397778;1750.1686698818087;1788.3383148235237;68835;68876;69373.95939060969;69577.30422695758;70379.64810175968;9974.251931105196;9974.351667141758;9998.350107243152;10219.335743176669;10410.115140213014;14226.573202803933;14231.50189743354;14257.073290236309;14276.357563909649;14299.714005720036;7129;7144.749933752294;7206.423486121098;7320.450966177558;7347.70609175627;6606.768763093365;6680.231773346128;6699.397054265042;6869.141357330333;6911.723531058802;4259.829606815692;4287.571242875688;4328.177646247203;4352.891177720519;4355.390245365651;1648.8433598808094;1725.9223334949957;1764.4882983934515;1896.6491199128207;1901.961960760777;423.75422255091974;855.3456605696647;964.4599024546136;973.6640858903667;1025.5128813813528;9230.261579073658;16214.75677864833;17056.759215748967;17146.39987600428;18216.544586385447;830.7881490219955;881.7971866470748;889.2219308105408;931.2038207332769;936.3819878879907;6353.904691429632;9217.861732074025;9588.089131532493;9696.127348538665;9707.320487565943;385355;387496.1875571869;390887;394123;426805.958212535;79043.60478197572;81737.59131204306;82327.4138068953;82807;85310.14689853146;1001.5142655811925;1001.972977697851;1012.1700205831148;1019.1591936652292;1027.5941003303653;14914.552563423114;15093.698126037198;15107.924460377628;15151.393944242107;15161.696766064397;34130.48804267888;34395;35225.82387088048;35631;35661.28677426385;47235.52764472449;48568;49452.752736237526;49856.501434985184;50593.494065058876;7695.422843286664;7882.290593846581;7888.092869320101;7896.170902055431;7955.164707705839;10699.8930010702;10813.513391897226;11154.944225278821;11327.660170194908;11446.94276528612;5769.826905192851;9781.41311521311;10172.314074310374;10206.948965255126;10472.057514823702;4907;9830.459324737209;10215.02957219063;10258.333208341433;10590.940905909347;10422.843657344994;10439.321444106108;10505.579776808841;10548.103411210133;10718.35689858611;7924.475747085117;7972.800679983046;7980.8802867955865;7999.840003199787;8119.634616442156;9637.22902167839;10386.48067596602;10594.4702764863;10710.303830251009;10714.67855964291 22:31:01 INFO - PROCESS | 22603 | |3;mootools.html;1367.5145323410188;1448.9058211216272;1563.4293482878745;1756.2272600055967;1777.3690339929333;6694.36403541664;7423.962880185605;7429.108506979163;7628.618569071545;7649.04386951631;7591.468597198198;7630.65662045208;7651.23487651236;7655.6937722491175;7720.498167619101;2248.2355998960393;2285.942851428719;2288.3706980580305;2289.748127705959;2292.3695983604475;2244.2818298144603;2266.660000999847;2266.9659955100688;2280.1791355112146;2281.9348489616923;2253.278950735765;2254.9098036078535;2281.0305620111385;2293.461036656393;2317.8609283443047;2223.144089525544;2226.6993955816;2234.519578290667;2240.350298413458;2242.416971587391;2208.4258092895802;2215.8227341812617;2219.5782801267706;2220.0675716199235;2226.142934970032;7571.810704732371;7757.8448431031065;7758.573278469682;7782.844343113163;7794.2985131338455;4521.434820647419;4606.677532572721;4643.489216186217;4655.650826188049;4658.883527911829;2851.429714057176;2956.5779757624236;3012.8794848206044;3050.435669401168;3056.5415187721796;994.2741798487073;998.6454808543008;999.5551979369184;1013.7212266626663;1022.0035465421229;10672.306300090548;10720.946395268053;10791.244612877103;10799;10819.459027048695;4183.686223533186;4266.0827921996915;4332.935005974913;4428.13651337986;4447.155040542287;9182.770430739285;9214.216791572657;9249;9265.397749146285;9283.257339412965;4738.123447162217;4738.8341408050555;4747.335373047776;4753.904921901542;4772;3713.090292878262;4253.787310634518;4295.033617436052;4331.198728235224;4394.2749446340995;3730.869419570302;3761.32296186689;3777.7355585109326;3820.834645433114;3830.1190726132586;1243.0676992255808;1245.4022069406735;1262.5896583610363;1267.0876968582606;1273.1724379153625;849.1254008371387;854.5855260198798;864.3992425264506;870.9303255739652;992.8014397120605;7146.32109949554;7262.927370726331;7270.16393114788;7276.63616819157;7294.525855819355;933.5658918602883;1013.2248829645328;1042.7758032023;1089.1341383600056;1094.3324572011068;5594.049011668027;5722.170285308607;5733.598648094593;5734.799282025193;5762.971185144047;8904.109589041043;9248.445093294424;9626.614935402646;9699.466529340954;9786.217102631772;9447.291453140904;9459.337846350689;9462;9472.715818525456;9515;6984.2317345092;7160.57036577807;7233.746818861315;7235.493515453973;7332.23011583776;7294.817629559304;7350.228226036189;7410.6665200065045;7440.888386674096;7490.438217133846;8826.823463530822;8913.197812196673;8965.058668839938;8999.685011024583;9160.587773550073;8847.20375166238;8929.687460938836;9198.080191980749;9243.39917905361;9249.630014799603;6531.771388001397;7202.423806095605;7289.5261807982315;7468.477206595486;7486.850262994819;7481.102267727908;7536.359409450258;7547.320741133324;7580.090389153116;7652.540847548942;6672.199336079701;6740.2248741393405;6816.216135144522;6861.862762744817;6925.861482770417;6483.189601299838;6505.869882602226;6523.151990241238;6597.637129957707;6628.07206991012;6702.899456508254;7239.855202895807;7295.379892709179;7346.228645992308;7346.77959661211;6600.669966501751;6630.071789949508;6655.600663960178;6679.098321726505;6681.69932353055;6425.614463132227;6496.0255961606135;6497.545171837926;6506.4469520091325;6517.8696426072165 22:31:01 INFO - PROCESS | 22603 | |4;prototype.html;298.9671136175021;301.19130135585954;305.58135354564234;306.7132231363675;307.55097557565955;5120.539151476366;5218.817341393052;5297.576193904488;5387.811426600069;5391.622586418952;5213.661112027716;5255.947440525593;5275.6043296752705;5279.260903473517;5315.893682126355;3810.428435734634;3921.1177485065773;4037.8586749463775;4051.561695598057;4061.3501839705655;4029.355303151496;4038.172174704179;4038.232735780207;4040.696947728917;4058.0666446717273;4006.596042374581;4008.198360327946;4008.5748122385976;4016.5180178378637;4019.658329042035;3789.3558095123894;4008.1582867597695;4009.6391324780766;4010.4585880905997;4018.2566225248424;3444.844981975792;3447.413939630269;3457.135716070982;3458.1354661334667;3467.271872906693;5024.115956516306;5029.396472423333;5034.89930201394;5039.168537191359;5081.5426611605135;4568.5431456854385;4574.0851829633875;4581.244094724367;4583.610393116589;4585.426821647294;5387.380451248078;5497.505224529771;5523.751431185607;5526.309211348582;5530.861728456781;3753.7560058596105;3779.1496913194587;3783.3568293389912;3785.1483416231404;3789.3747531657245;5768.394318596529;5783.392743761887;5820;5829.154772557998;5846.50304724099;3726.7018638508853;3885.417187421909;3890.7860067696547;3891.0855948851995;3906.374980003186;3912.8630497933004;3945.881623551298;3947.684185265172;3954.5056867891512;3956.5252169739815;4525.411696479437;4574.336721175411;4584.243599805995;4588.885277868013;4589.380433641482;5388.353397592314;5532.363778165482;5550.611457197957;5582.860428489239;5586.55307575393;1367.6375760423496;1374.2098293481288;1382.8893688504895;1388.7430825297351;1392.3595146232847;875.1205038935828;895.5029958373166;897.7261935109724;900.8018235988203;919.5769945824995;4652.930206046912;4665.790039448233;4877.292792545061;4898.093852637274;4910.116179087727;5743.655380677173;5771.192033115367;5797.057985574796;5799.18811366409;5804.622699524602;4633.86098417048;4891.51084891508;4900.583450406684;4906.803727850917;4909.926351104737;3034.908952731377;3081.7226449619193;3097.2102113960796;3101.9379612407624;3102.146909599878;5409.323834520685;5456.645318054393;5459.563234941195;5461.5357694596405;5471.261379713687;5768.010036537388;5872.882542349214;5913.142594323799;5928.555358348141;5931.1992880960515;5387.919181212285;5431.4840090191365;5443.7822487100075;5444;5459.590530710213;5582.106862901916;5729.885402292014;5738.540916726568;5775.595708300379;5786.710664466676;5655.8249201979725;5681.630694004876;5692;5700.942990570207;5704.914426283526;5359.124306492697;5390.27231323782;5407.242985981887;5411.864703382447;5434.83695489136;3845.8077995821386;3868.129670824042;3880.4955355803563;3935.4490371348606;3955.821988010604;5698.0598201296325;5701.629394089371;5710.801341483641;5711.257536520226;5734.283214598176;5532.446755324436;5561.805336813192;5576.832695019156;5578.665280083208;5579.553635709215;5250.50120238592;5564.081926482085;5566.916496252478;5576.275084239023;5580.441955804387;5400.378956419905;5429.375621803543;5436.429174936733;5446.945530544644;5481.588880833874;5288.620120945667;5383.784648614168;5539.667619942817;5557.3331200256225;5582.720863956704;5343.385510666168;5409.107497263065;5414.35027796667;5415.945840541544;5437.238786569805 22:31:01 INFO - PROCESS | 22603 | |5;yui.html;660.6003367962383;661.5137873662859;737.3327138939262;756.8183635927372;788.5229436191104;11608.825867611993;12337.136400451973;12554.937225313872;12962.351882405888;12999.220046797187;13179.6705082373;13293.933530332359;13368.264745438997;13372.598822035354;13375.464981400757;818.6111596991441;822.3791037766508;831.6756464978663;833.3458235285302;833.4499230507867;806.7741032510907;810.4165001199157;813.4021494201756;814.3932770086294;819.2422009641058;863.0678866823815;863.2101627011277;863.6804382378498;864.3085531574746;869.0180096490957;849.7748096754365;861.7070196133313;862.9956850215772;863.2144748279068;863.2964134230582;617.1360095865779;628.0202883501752;630.0643544336656;630.6216270237867;632.7121159872247;12814.551490697873;12834.743305133845;12838.871611283861;12845.486180552767;12887.548935787296;11852.525898964032;12083.758324833541;12118.454669539891;12217.083718721131;13502.864971350356;8776.210141087333;8780.780480487974;8899.466032038034;8969.551522423853;9085.318601104878;3279.262166012628;3332.600087989457;3341.8496167672515;3351.145457908218;3393.8472768725464;41325.58674413277;41449.378259326135;43255.35116973248;47672;48077.27884081707;9279.211267042241;9284.25725941923;9347.298952578583;9411.482368469662;9512.953575106732;16703.331866725195;16894.070826104435;16960.406385776438;16967;17004.65990680204;6646.833829154213;6659.034440006172;6706.329367063352;6723.562968407038;6851.623160726208;3724.1248306647917;3792.981035094807;3827.5789663137034;3839.3856982882603;3874.2057878134915;2700.2574292069444;2819.4783964966546;3208.7914285571364;3345.2640419107756;3350.7319414447275;551.9944800551943;559.560744815318;560.8009156749376;574.5116650846746;583.877385748989;524.4781442464772;583.5944018906904;600.4145957691303;614.7295190116334;615.6952308607179;7630.923690763132;7707.113681926538;7889.526628402315;8051.2351326623875;8057.6776928923355;591.2963573347703;591.7810410148272;619.7768803230833;623.4357906094991;643.7521554201666;3626.854925802991;3660.5707094415525;3693.3351996640863;3846.2692088503095;3852.3643598805884;46958.76520617375;49903;49943.25085123726;50413.747931260106;50685;44478.33282500765;45001.549984500394;45176;45668;45690.31464528035;38915;39710.20579588392;40153.39769903395;40836;42231.15537689229;7163.570185788869;7189.245129261352;7211.1707153678;7229.385502232369;7340.412766978736;26908.59637105406;27473.587896181172;28214;28274;28385.432291353645;33238.66761332356;35974.64025359713;36338.09154771152;36481.81759091187;36620.45069323909;8521.786955325919;8588.613512392083;8600.698975535826;8651.6106775194;8678.132186781271;9939.900600993897;9986.850197247193;10132.74668133273;10266.486675666336;10366.712976381948;8800.47197168172;9680.661176858775;10816.67549973502;10895.727606809893;10975.670729878117;9708.805823883342;9798.804023919623;9959;10974;11172.106231501299;9547;9562.95218523903;9799.804003920024;10159.542820572944;10868.293560918515;8898.421602596069;8947.642094316154;9047.5482175615;9360;9471.763205919631;8155.184481551797;9275.86086208694;9348.439093654402;9353.204977576983;9357.01751316102 22:31:01 INFO - PROCESS | 22603 | __end_tp_report 22:31:01 INFO - PROCESS | 22603 | __start_cc_report 22:31:01 INFO - PROCESS | 22603 | _x_x_mozilla_cycle_collect,361 22:31:01 INFO - PROCESS | 22603 | __end_cc_report 22:31:01 INFO - PROCESS | 22603 | __startTimestamp1460439061114__endTimestamp 22:31:01 INFO - PROCESS | 22603 | 22:31:01 INFO - PROCESS | 22603 | ------- Summary: start ------- 22:31:01 INFO - PROCESS | 22603 | Number of tests: 6 22:31:01 INFO - PROCESS | 22603 | 22:31:01 INFO - PROCESS | 22603 | [#0] dojo.html Cycles:165 Average:4656.01 Median:4806.81 stddev:576.72 (12.0%) stddev-sans-first:555.93 22:31:01 INFO - PROCESS | 22603 | Values: 2619.8 2692.4 2693.2 2720.1 2722.7 4586.8 4601.1 4601.9 4626.6 4675.0 4617.0 4653.0 4682.0 4734.5 4743.1 4317.3 4345.2 4381.1 4402.5 4409.7 531.3 4317.8 4367.7 4375.2 4450.4 4395.2 4395.5 4398.3 4398.6 4441.6 4226.3 4459.0 4476.9 4478.0 4518.5 4252.8 4282.5 4310.8 4315.4 4326.2 4600.9 4623.1 4625.0 4689.0 4729.0 4947.8 5003.9 5040.9 5059.4 5072.1 5121.9 5128.3 5129.8 5145.4 5156.6 4739.9 4782.8 4786.7 4792.3 4837.1 5088.9 5211.1 5270.0 5305.7 5317.5 4999.4 5004.4 5007.3 5011.7 5075.6 5079.5 5097.7 5101.3 5114.3 5120.3 4869.2 4981.4 5029.3 5049.4 5089.2 4877.9 4984.1 5001.6 5021.0 5070.8 4315.3 4342.2 4345.8 4381.3 4381.6 3713.5 3772.9 3794.9 3812.4 3830.9 4347.3 4362.1 4373.3 4395.5 4410.0 5027.8 5033.7 5035.0 5054.5 5104.3 4357.5 4361.2 4372.7 4401.7 4407.1 4525.2 4553.8 4572.9 4591.4 4609.9 4739.4 4773.6 4790.9 4810.7 4813.6 4945.2 4997.7 4998.2 5030.6 5036.9 4743.5 4746.1 4760.1 4772.3 4806.8 4835.7 4946.7 4994.1 5034.1 5073.3 5036.8 5043.2 5065.6 5077.0 5122.7 4894.6 4915.5 4918.4 4922.8 4976.4 4812.7 4903.5 4914.9 4952.4 4990.6 4699.0 4820.5 4820.7 4825.9 4900.2 4940.0 4968.8 4977.6 4980.1 5027.4 4652.6 4831.2 4872.8 4889.7 4917.2 22:31:01 INFO - PROCESS | 22603 | 22:31:01 INFO - PROCESS | 22603 | [#1] ext.html Cycles:180 Average:46649.24 Median:189630.24 stddev:86569.56 (45.7%) stddev-sans-first:86743.28 22:31:01 INFO - PROCESS | 22603 | Values: 571.2 599.1 607.1 614.7 629.4 30341.5 31060.2 31187.2 31298.2 31305.4 35575.0 36013.3 36131.1 36218.0 36299.8 7429.7 7547.0 7556.5 7597.8 7611.2 7513.9 7777.0 7787.1 7798.2 7798.8 7536.6 7606.4 7631.4 7633.7 7642.1 7704.1 7743.8 7803.0 7818.4 7821.5 7674.3 7723.5 7727.5 7744.2 7758.2 29415.6 34761.5 35158.5 35202.3 35246.8 2883.3 2940.5 2952.4 2975.9 3025.9 27142.0 28196.9 28495.7 28743.3 29123.7 3151.3 3175.7 3190.5 3209.4 3253.9 318360.0 327968.0 328434.0 329516.0 329561.0 35445.6 36282.8 36509.1 58995.0 59698.7 35806.0 35948.8 36003.3 36068.6 36136.5 13110.9 13348.9 13356.4 13361.7 13377.6 10278.1 10283.3 10300.3 10324.7 10369.8 8200.1 8253.5 8293.9 8320.3 8338.9 3258.9 3263.1 3268.6 3300.4 3321.5 899.4 908.7 950.3 990.7 993.7 27087.0 28709.7 28782.4 29015.1 29308.4 1000.8 1012.4 1017.3 1029.2 1039.3 14909.8 15437.8 15439.3 15461.9 15709.1 334668.0 342475.0 343876.0 344403.0 344499.0 47132.8 48004.3 48080.3 48096.3 48122.5 1215.8 1229.1 1242.8 1260.0 1275.3 26770.3 27649.6 27705.7 27982.0 28634.1 44055.3 44273.3 44711.3 44723.3 44774.3 311423.0 314358.0 318590.0 318790.0 319630.0 25553.5 25876.5 25998.0 26082.9 26189.6 41488.0 42003.0 42192.0 42571.8 42943.6 36602.5 36918.8 37079.4 37486.8 37709.4 35493.0 36042.5 36252.5 36490.5 37405.0 35896.6 36217.0 36430.5 36511.0 36661.5 30886.1 32379.5 32684.4 32846.8 32980.8 24856.0 25144.4 25278.9 25471.6 25539.4 22:31:01 INFO - PROCESS | 22603 | 22:31:01 INFO - PROCESS | 22603 | [#2] jquery.html Cycles:180 Average:24249.78 Median:4307.87 stddev:65689.13 (1524.9%) stddev-sans-first:65848.92 22:31:01 INFO - PROCESS | 22603 | Values: 363.5 363.7 376.7 384.1 391.0 15598.1 16544.9 17403.4 17606.6 17629.2 15746.2 16154.1 16802.6 16907.5 16990.3 5058.2 5183.8 5190.1 5226.3 5229.8 3712.2 5102.2 5716.7 6067.4 6075.5 5951.5 5978.9 5984.3 5991.6 6011.0 4884.0 5200.5 5205.2 5208.3 5209.4 4536.6 4854.9 4855.0 5035.0 5042.3 11857.2 11960.1 12098.5 13132.9 20177.2 1818.6 1850.5 2039.0 2106.0 2266.0 8516.3 9213.4 9341.4 9363.1 9494.7 1707.9 1709.5 1735.9 1750.2 1788.3 68835.0 68876.0 69374.0 69577.3 70379.6 9974.3 9974.4 9998.4 10219.3 10410.1 14226.6 14231.5 14257.1 14276.4 14299.7 7129.0 7144.7 7206.4 7320.5 7347.7 6606.8 6680.2 6699.4 6869.1 6911.7 4259.8 4287.6 4328.2 4352.9 4355.4 1648.8 1725.9 1764.5 1896.6 1902.0 423.8 855.3 964.5 973.7 1025.5 9230.3 16214.8 17056.8 17146.4 18216.5 830.8 881.8 889.2 931.2 936.4 6353.9 9217.9 9588.1 9696.1 9707.3 385355.0 387496.2 390887.0 394123.0 426806.0 79043.6 81737.6 82327.4 82807.0 85310.1 1001.5 1002.0 1012.2 1019.2 1027.6 14914.6 15093.7 15107.9 15151.4 15161.7 34130.5 34395.0 35225.8 35631.0 35661.3 47235.5 48568.0 49452.8 49856.5 50593.5 7695.4 7882.3 7888.1 7896.2 7955.2 10699.9 10813.5 11154.9 11327.7 11446.9 5769.8 9781.4 10172.3 10206.9 10472.1 4907.0 9830.5 10215.0 10258.3 10590.9 10422.8 10439.3 10505.6 10548.1 10718.4 7924.5 7972.8 7980.9 7999.8 8119.6 9637.2 10386.5 10594.5 10710.3 10714.7 22:31:01 INFO - PROCESS | 22603 | 22:31:01 INFO - PROCESS | 22603 | [#3] mootools.html Cycles:180 Average:5484.15 Median:6599.15 stddev:2882.20 (43.7%) stddev-sans-first:2873.67 22:31:01 INFO - PROCESS | 22603 | Values: 1367.5 1448.9 1563.4 1756.2 1777.4 6694.4 7424.0 7429.1 7628.6 7649.0 7591.5 7630.7 7651.2 7655.7 7720.5 2248.2 2285.9 2288.4 2289.7 2292.4 2244.3 2266.7 2267.0 2280.2 2281.9 2253.3 2254.9 2281.0 2293.5 2317.9 2223.1 2226.7 2234.5 2240.4 2242.4 2208.4 2215.8 2219.6 2220.1 2226.1 7571.8 7757.8 7758.6 7782.8 7794.3 4521.4 4606.7 4643.5 4655.7 4658.9 2851.4 2956.6 3012.9 3050.4 3056.5 994.3 998.6 999.6 1013.7 1022.0 10672.3 10720.9 10791.2 10799.0 10819.5 4183.7 4266.1 4332.9 4428.1 4447.2 9182.8 9214.2 9249.0 9265.4 9283.3 4738.1 4738.8 4747.3 4753.9 4772.0 3713.1 4253.8 4295.0 4331.2 4394.3 3730.9 3761.3 3777.7 3820.8 3830.1 1243.1 1245.4 1262.6 1267.1 1273.2 849.1 854.6 864.4 870.9 992.8 7146.3 7262.9 7270.2 7276.6 7294.5 933.6 1013.2 1042.8 1089.1 1094.3 5594.0 5722.2 5733.6 5734.8 5763.0 8904.1 9248.4 9626.6 9699.5 9786.2 9447.3 9459.3 9462.0 9472.7 9515.0 6984.2 7160.6 7233.7 7235.5 7332.2 7294.8 7350.2 7410.7 7440.9 7490.4 8826.8 8913.2 8965.1 8999.7 9160.6 8847.2 8929.7 9198.1 9243.4 9249.6 6531.8 7202.4 7289.5 7468.5 7486.9 7481.1 7536.4 7547.3 7580.1 7652.5 6672.2 6740.2 6816.2 6861.9 6925.9 6483.2 6505.9 6523.2 6597.6 6628.1 6702.9 7239.9 7295.4 7346.2 7346.8 6600.7 6630.1 6655.6 6679.1 6681.7 6425.6 6496.0 6497.5 6506.4 6517.9 22:31:01 INFO - PROCESS | 22603 | 22:31:01 INFO - PROCESS | 22603 | [#4] prototype.html Cycles:180 Average:4563.35 Median:5277.43 stddev:1365.76 (25.9%) stddev-sans-first:1331.56 22:31:01 INFO - PROCESS | 22603 | Values: 299.0 301.2 305.6 306.7 307.6 5120.5 5218.8 5297.6 5387.8 5391.6 5213.7 5255.9 5275.6 5279.3 5315.9 3810.4 3921.1 4037.9 4051.6 4061.4 4029.4 4038.2 4038.2 4040.7 4058.1 4006.6 4008.2 4008.6 4016.5 4019.7 3789.4 4008.2 4009.6 4010.5 4018.3 3444.8 3447.4 3457.1 3458.1 3467.3 5024.1 5029.4 5034.9 5039.2 5081.5 4568.5 4574.1 4581.2 4583.6 4585.4 5387.4 5497.5 5523.8 5526.3 5530.9 3753.8 3779.1 3783.4 3785.1 3789.4 5768.4 5783.4 5820.0 5829.2 5846.5 3726.7 3885.4 3890.8 3891.1 3906.4 3912.9 3945.9 3947.7 3954.5 3956.5 4525.4 4574.3 4584.2 4588.9 4589.4 5388.4 5532.4 5550.6 5582.9 5586.6 1367.6 1374.2 1382.9 1388.7 1392.4 875.1 895.5 897.7 900.8 919.6 4652.9 4665.8 4877.3 4898.1 4910.1 5743.7 5771.2 5797.1 5799.2 5804.6 4633.9 4891.5 4900.6 4906.8 4909.9 3034.9 3081.7 3097.2 3101.9 3102.1 5409.3 5456.6 5459.6 5461.5 5471.3 5768.0 5872.9 5913.1 5928.6 5931.2 5387.9 5431.5 5443.8 5444.0 5459.6 5582.1 5729.9 5738.5 5775.6 5786.7 5655.8 5681.6 5692.0 5700.9 5704.9 5359.1 5390.3 5407.2 5411.9 5434.8 3845.8 3868.1 3880.5 3935.4 3955.8 5698.1 5701.6 5710.8 5711.3 5734.3 5532.4 5561.8 5576.8 5578.7 5579.6 5250.5 5564.1 5566.9 5576.3 5580.4 5400.4 5429.4 5436.4 5446.9 5481.6 5288.6 5383.8 5539.7 5557.3 5582.7 5343.4 5409.1 5414.4 5415.9 5437.2 22:31:01 INFO - PROCESS | 22603 | 22:31:01 INFO - PROCESS | 22603 | [#5] yui.html Cycles:180 Average:12196.53 Median:583.74 stddev:13765.38 (2358.2%) stddev-sans-first:13776.74 22:31:01 INFO - PROCESS | 22603 | Values: 660.6 661.5 737.3 756.8 788.5 11608.8 12337.1 12554.9 12962.4 12999.2 13179.7 13293.9 13368.3 13372.6 13375.5 818.6 822.4 831.7 833.3 833.4 806.8 810.4 813.4 814.4 819.2 863.1 863.2 863.7 864.3 869.0 849.8 861.7 863.0 863.2 863.3 617.1 628.0 630.1 630.6 632.7 12814.6 12834.7 12838.9 12845.5 12887.5 11852.5 12083.8 12118.5 12217.1 13502.9 8776.2 8780.8 8899.5 8969.6 9085.3 3279.3 3332.6 3341.8 3351.1 3393.8 41325.6 41449.4 43255.4 47672.0 48077.3 9279.2 9284.3 9347.3 9411.5 9513.0 16703.3 16894.1 16960.4 16967.0 17004.7 6646.8 6659.0 6706.3 6723.6 6851.6 3724.1 3793.0 3827.6 3839.4 3874.2 2700.3 2819.5 3208.8 3345.3 3350.7 552.0 559.6 560.8 574.5 583.9 524.5 583.6 600.4 614.7 615.7 7630.9 7707.1 7889.5 8051.2 8057.7 591.3 591.8 619.8 623.4 643.8 3626.9 3660.6 3693.3 3846.3 3852.4 46958.8 49903.0 49943.3 50413.7 50685.0 44478.3 45001.5 45176.0 45668.0 45690.3 38915.0 39710.2 40153.4 40836.0 42231.2 7163.6 7189.2 7211.2 7229.4 7340.4 26908.6 27473.6 28214.0 28274.0 28385.4 33238.7 35974.6 36338.1 36481.8 36620.5 8521.8 8588.6 8600.7 8651.6 8678.1 9939.9 9986.9 10132.7 10266.5 10366.7 8800.5 9680.7 10816.7 10895.7 10975.7 9708.8 9798.8 9959.0 10974.0 11172.1 9547.0 9563.0 9799.8 10159.5 10868.3 8898.4 8947.6 9047.5 9360.0 9471.8 8155.2 9275.9 9348.4 9353.2 9357.0 22:31:01 INFO - PROCESS | 22603 | -------- Summary: end -------- 22:31:01 INFO - PROCESS | 22603 | 22:31:01 INFO - TEST-INFO | 22603: exit 0 22:31:01 INFO - TEST-OK | dromaeo_css | took 1115563ms 22:31:01 INFO - TEST-START | kraken 22:31:01 INFO - operating with platform_type : linux_ 22:31:01 INFO - Initialising browser for kraken test... 22:31:01 INFO - TEST-INFO | started process 22842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebFCc3/profile http://localhost:36414/getInfo.html) 22:31:05 INFO - PROCESS | 22842 | 22:31:05 INFO - PROCESS | 22842 | (process:22911): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:31:05 INFO - PROCESS | 22842 | 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] 22:31:06 INFO - PROCESS | 22842 | __metrics Screen width/height:1600/1200 22:31:06 INFO - PROCESS | 22842 | colorDepth:24 22:31:06 INFO - PROCESS | 22842 | Browser inner width/height: 1024/697 22:31:06 INFO - PROCESS | 22842 | __metrics 22:31:07 ERROR - PROCESS | 22842 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 22:31:08 INFO - TEST-INFO | 22842: exit 0 22:31:08 INFO - Browser initialized. 22:31:08 INFO - Running cycle 1/1 for kraken test... 22:31:08 INFO - TEST-INFO | started process 22963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebFCc3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:31:09 INFO - PROCESS | 22963 | 22:31:09 INFO - PROCESS | 22963 | (process:23023): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:31:19 INFO - PROCESS | 22963 | RSS: Main: 164679680 22:31:19 INFO - PROCESS | 22963 | 22:31:22 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36414/tests/kraken/driver.html?testName=audio-beat-detection) 22:31:23 INFO - PROCESS | 22963 | RSS: Main: 168534016 22:31:23 INFO - PROCESS | 22963 | 22:31:26 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36414/tests/kraken/driver.html?testName=audio-dft) 22:31:27 INFO - PROCESS | 22963 | RSS: Main: 171933696 22:31:27 INFO - PROCESS | 22963 | 22:31:29 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36414/tests/kraken/driver.html?testName=audio-fft) 22:31:30 INFO - PROCESS | 22963 | RSS: Main: 164782080 22:31:30 INFO - PROCESS | 22963 | 22:31:32 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36414/tests/kraken/driver.html?testName=audio-oscillator) 22:31:33 INFO - PROCESS | 22963 | RSS: Main: 165068800 22:31:33 INFO - PROCESS | 22963 | 22:31:35 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36414/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:31:36 INFO - PROCESS | 22963 | RSS: Main: 165335040 22:31:36 INFO - PROCESS | 22963 | 22:31:39 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36414/tests/kraken/driver.html?testName=imaging-darkroom) 22:31:40 INFO - PROCESS | 22963 | RSS: Main: 165523456 22:31:40 INFO - PROCESS | 22963 | 22:31:43 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36414/tests/kraken/driver.html?testName=imaging-desaturate) 22:31:44 INFO - PROCESS | 22963 | RSS: Main: 162910208 22:31:44 INFO - PROCESS | 22963 | 22:31:47 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36414/tests/kraken/driver.html?testName=json-parse-financial) 22:31:47 INFO - PROCESS | 22963 | RSS: Main: 164057088 22:31:47 INFO - PROCESS | 22963 | 22:31:49 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36414/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:31:50 INFO - PROCESS | 22963 | RSS: Main: 164442112 22:31:50 INFO - PROCESS | 22963 | 22:31:51 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36414/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:31:52 INFO - PROCESS | 22963 | RSS: Main: 164302848 22:31:52 INFO - PROCESS | 22963 | 22:31:54 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36414/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:31:55 INFO - PROCESS | 22963 | RSS: Main: 164663296 22:31:55 INFO - PROCESS | 22963 | 22:31:58 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:31:59 INFO - PROCESS | 22963 | RSS: Main: 165101568 22:31:59 INFO - PROCESS | 22963 | 22:32:01 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:32:02 INFO - PROCESS | 22963 | RSS: Main: 164937728 22:32:02 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | Cycle 1(1): loaded http://localhost:36414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36414/tests/kraken/driver.html?testName=ai-astar) 22:32:04 INFO - PROCESS | 22963 | RSS: Main: 166473728 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | __start_tp_report 22:32:04 INFO - PROCESS | 22963 | _x_x_mozilla_page_load 22:32:04 INFO - PROCESS | 22963 | _x_x_mozilla_page_load_details 22:32:04 INFO - PROCESS | 22963 | |i|pagename|runs| 22:32:04 INFO - PROCESS | 22963 | |0;ai-astar;116;109;113;115;114;127;113;112;113;114 22:32:04 INFO - PROCESS | 22963 | |1;audio-beat-detection;158;137;162;192;138;155;158;134;204;136 22:32:04 INFO - PROCESS | 22963 | |2;audio-dft;162;163;162;163;172;162;162;164;165;164 22:32:04 INFO - PROCESS | 22963 | |3;audio-fft;74;77;77;160;75;76;76;73;157;75 22:32:04 INFO - PROCESS | 22963 | |4;audio-oscillator;95;94;150;94;95;93;141;94;93;145 22:32:04 INFO - PROCESS | 22963 | |5;imaging-gaussian-blur;117;118;117;118;117;118;118;117;118;118 22:32:04 INFO - PROCESS | 22963 | |6;imaging-darkroom;147;147;147;148;147;146;147;147;147;147 22:32:04 INFO - PROCESS | 22963 | |7;imaging-desaturate;98;95;96;96;96;95;96;96;96;95 22:32:04 INFO - PROCESS | 22963 | |8;json-parse-financial;64;65;65;66;66;68;65;80;63;62 22:32:04 INFO - PROCESS | 22963 | |9;json-stringify-tinderbox;62;67;63;64;65;64;64;65;63;64 22:32:04 INFO - PROCESS | 22963 | |10;stanford-crypto-aes;86;86;84;84;86;91;87;93;87;84 22:32:04 INFO - PROCESS | 22963 | |11;stanford-crypto-ccm;141;148;138;150;144;140;138;144;170;140 22:32:04 INFO - PROCESS | 22963 | |12;stanford-crypto-pbkdf2;175;179;175;177;176;174;179;173;176;175 22:32:04 INFO - PROCESS | 22963 | |13;stanford-crypto-sha256-iterative;79;78;72;73;70;72;72;72;74;72 22:32:04 INFO - PROCESS | 22963 | __end_tp_report 22:32:04 INFO - PROCESS | 22963 | __start_cc_report 22:32:04 INFO - PROCESS | 22963 | _x_x_mozilla_cycle_collect,920 22:32:04 INFO - PROCESS | 22963 | __end_cc_report 22:32:04 INFO - PROCESS | 22963 | __startTimestamp1460439124653__endTimestamp 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | ------- Summary: start ------- 22:32:04 INFO - PROCESS | 22963 | Number of tests: 14 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.00 stddev:4.74 (4.2%) stddev-sans-first:5.00 22:32:04 INFO - PROCESS | 22963 | Values: 116.0 109.0 113.0 115.0 114.0 127.0 113.0 112.0 113.0 114.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:158.00 stddev:24.02 (15.2%) stddev-sans-first:25.48 22:32:04 INFO - PROCESS | 22963 | Values: 158.0 137.0 162.0 192.0 138.0 155.0 158.0 134.0 204.0 136.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:3.03 (1.9%) stddev-sans-first:3.14 22:32:04 INFO - PROCESS | 22963 | Values: 162.0 163.0 162.0 163.0 172.0 162.0 162.0 164.0 165.0 164.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.50 stddev:35.08 (46.5%) stddev-sans-first:36.60 22:32:04 INFO - PROCESS | 22963 | Values: 74.0 77.0 77.0 160.0 75.0 76.0 76.0 73.0 157.0 75.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:94.00 stddev:24.90 (26.5%) stddev-sans-first:25.86 22:32:04 INFO - PROCESS | 22963 | Values: 95.0 94.0 150.0 94.0 95.0 93.0 141.0 94.0 93.0 145.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:32:04 INFO - PROCESS | 22963 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 22:32:04 INFO - PROCESS | 22963 | Values: 147.0 147.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.50 22:32:04 INFO - PROCESS | 22963 | Values: 98.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:65.50 stddev:5.06 (7.7%) stddev-sans-first:5.29 22:32:04 INFO - PROCESS | 22963 | Values: 64.0 65.0 65.0 66.0 66.0 68.0 65.0 80.0 63.0 62.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:1.37 (2.1%) stddev-sans-first:1.22 22:32:04 INFO - PROCESS | 22963 | Values: 62.0 67.0 63.0 64.0 65.0 64.0 64.0 65.0 63.0 64.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:3.01 (3.5%) stddev-sans-first:3.18 22:32:04 INFO - PROCESS | 22963 | Values: 86.0 86.0 84.0 84.0 86.0 91.0 87.0 93.0 87.0 84.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:144.00 stddev:9.57 (6.6%) stddev-sans-first:10.02 22:32:04 INFO - PROCESS | 22963 | Values: 141.0 148.0 138.0 150.0 144.0 140.0 138.0 144.0 170.0 140.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:176.00 stddev:1.97 (1.1%) stddev-sans-first:2.06 22:32:04 INFO - PROCESS | 22963 | Values: 175.0 179.0 175.0 177.0 176.0 174.0 179.0 173.0 176.0 175.0 22:32:04 INFO - PROCESS | 22963 | 22:32:04 INFO - PROCESS | 22963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:72.50 stddev:2.88 (4.0%) stddev-sans-first:2.22 22:32:04 INFO - PROCESS | 22963 | Values: 79.0 78.0 72.0 73.0 70.0 72.0 72.0 72.0 74.0 72.0 22:32:04 INFO - PROCESS | 22963 | -------- Summary: end -------- 22:32:04 INFO - PROCESS | 22963 | 22:32:05 INFO - TEST-INFO | 22963: exit 0 22:32:05 INFO - TEST-OK | kraken | took 63871ms 22:32:05 INFO - SUITE-END | took 1179s 22:32:05 INFO - Completed test suite (00:19:39) 22:32:05 INFO - javascript benchmark 22:32:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.777318927891, 2692.3807524269428, 2693.2458911504787, 2720.143154906206, 2722.74133957274, 4586.793594288257, 4601.102784956931, 4601.907961840761, 4626.560476754707, 4674.976625116869, 4616.953830461694, 4652.999999999992, 4681.976590117053, 4734.455537613176, 4743.146233677937, 4317.33081372387, 4345.174416860787, 4381.123775244948, 4402.471703395597, 4409.735415875041, 531.2921553745318, 4317.76252306123, 4367.672424568154, 4375.212461756899, 4450.421445212134, 4395.230834603964, 4395.450568678915, 4398.34024896265, 4398.626116780078, 4441.555844415565, 4226.281532139544, 4459.0413061192, 4476.932846007313, 4477.977610111961, 4518.457785065781, 4252.808623611945, 4282.464691913511, 4310.80601372939, 4315.3742707307265, 4326.199653064194, 4600.907981840378, 4623.052274283764, 4624.953750462486, 4689.038747056845, 4729.006908549209, 4947.802087916479, 5003.924941125886, 5040.924386134211, 5059.418166910778, 5072.137736584789, 5121.871953201163, 5128.282040514331, 5129.794808207667, 5145.434002259786, 5156.587473002151, 4739.928901066487, 4782.832600858988, 4786.712797232177, 4792.329073929653, 4837.0567739290855, 5088.872778180576, 5211.088059589557, 5270.0, 5305.734713264322, 5317.54800841925, 4999.375078115236, 5004.449510553836, 5007.298978143063, 5011.674241174312, 5075.593952483792, 5079.517445842639, 5097.668651537638, 5101.336826212643, 5114.335136432314, 5120.283160357553, 4869.245266983623, 4981.352424184905, 5029.346184996, 5049.394072711299, 5089.185730283211, 4877.902441951142, 4984.077945580007, 5001.64988450805, 5021.0, 5070.847874563769, 4315.331123675835, 4342.174986752507, 4345.826166953287, 4381.277089280296, 4381.605655491021, 3713.4801127842125, 3772.9434058489146, 3794.880510249483, 3812.3900175972267, 3830.8659196927974, 4347.282698354799, 4362.062156636339, 4373.2565463871215, 4395.538468460765, 4409.977950110229, 5027.79888804451, 5033.748312584356, 5034.967831594514, 5054.4692807254705, 5104.3109180260935, 4357.54245804186, 4361.193179261783, 4372.672049596293, 4401.735895846259, 4407.118576284692, 4525.208088584484, 4553.795079221377, 4572.862814115582, 4591.403117594691, 4609.861704148881, 4739.360186374795, 4773.64197685175, 4790.880227994258, 4810.687305325143, 4813.638977076804, 4945.184044632595, 4997.725125118153, 4998.225275082368, 5030.572401345927, 5036.949630503648, 4743.501932297059, 4746.050789842115, 4760.119377914958, 4772.331873537638, 4806.807727690853, 4835.685680430761, 4946.703197808143, 4994.101061808764, 5034.119029169808, 5073.315102461121, 5036.798528058983, 5043.2435134730085, 5065.645404821627, 5077.0, 5122.74386280677, 4894.559489645949, 4915.5330243626795, 4918.360613120414, 4922.803087876445, 4976.427710813303, 4812.687175333592, 4903.460619331942, 4914.901701966012, 4952.4304704959395, 4990.6007519397635, 4698.976505117589, 4820.493848145894, 4820.734859582757, 4825.9034819302715, 4900.166971614763, 4940.036692845005, 4968.801247950186, 4977.626677999092, 4980.128477516492, 5027.396712394536, 4652.55800698933, 4831.154547954165, 4872.756362181947, 4889.682170658896, 4917.237828136645], "value": 4622.625966145183, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.191763654429, 599.1342510072946, 607.0560278766517, 614.6527212125147, 629.44608744305, 30341.544876826836, 31060.22349441265, 31187.220319492026, 31298.217544561398, 31305.373892522137, 35575.0, 36013.279734405296, 36131.09672258188, 36218.0, 36299.818500907524, 7429.739959101446, 7547.018887544611, 7556.546607203558, 7597.810054748647, 7611.2388761124, 7513.887291690629, 7776.961115194416, 7787.143414224459, 7798.181190974951, 7798.80502987427, 7536.623168841536, 7606.3914886808925, 7631.427642926775, 7633.732819351324, 7642.082950046002, 7704.0755109386955, 7743.845123097534, 7803.0, 7818.37453003764, 7821.530708157472, 7674.347680447168, 7723.53658780475, 7727.536347819148, 7744.225577442267, 7758.185390533969, 29415.558766618517, 34761.478577821355, 35158.472622910675, 35202.29595408077, 35246.823765881265, 2883.336832528509, 2940.491007452883, 2952.409518096389, 2975.851207439641, 3025.9243518911985, 27142.0, 28196.85901570479, 28495.715042849515, 28743.28141796451, 29123.708762912313, 3151.322465669869, 3175.6506784253716, 3190.5054716518976, 3209.3902158589794, 3253.9186520336943, 318360.0, 327968.0, 328434.0, 329516.0, 329561.0, 35445.64554354475, 36282.8185859069, 36509.08727281786, 58995.0, 59698.70150649219, 35806.0, 35948.82025589855, 36003.279934401166, 36068.639313607055, 36136.457953130724, 13110.934445327712, 13348.93325533366, 13356.398962046536, 13361.732765344834, 13377.598672039854, 10278.074973252444, 10283.280170388001, 10300.278980471445, 10324.741881452874, 10369.844452333222, 8200.097989221182, 8253.463524870864, 8293.875591866126, 8320.334373250125, 8338.916610833936, 3258.8859389921713, 3263.1352691536763, 3268.591426071741, 3300.3564304960782, 3321.501774733761, 899.392909785905, 908.68650315641, 950.2825366848124, 990.6582229130938, 993.7465946183821, 27087.0, 28709.712902870702, 28782.42435151285, 29015.12954611365, 29308.413831723246, 1000.8348622477355, 1012.3976234140674, 1017.2574020964737, 1029.1869423155772, 1039.262123892045, 14909.776353354708, 15437.768433473508, 15439.30523126462, 15461.922690386476, 15709.135997520018, 334668.0, 342475.0, 343876.0, 344403.0, 344499.0, 47132.7643361781, 48004.279935800994, 48080.27879581809, 48096.27855582169, 48122.518774811804, 1215.769003889258, 1229.1211783574608, 1242.8384310039637, 1259.9748005039849, 1275.3113318807739, 26770.330741730835, 27649.58525622077, 27705.72294277112, 27982.0, 28634.14097577076, 44055.33916991312, 44273.33589996088, 44711.32933005942, 44723.32915006342, 44774.3283850736, 311423.0, 314358.0, 318590.0, 318790.0, 319630.0, 25553.48893022166, 25876.48247035011, 25998.0, 26082.86958565271, 26189.607155893056, 41488.0, 42003.0, 42192.0, 42571.787141064095, 42943.57056429521, 36602.45096323504, 36918.81540592387, 37079.443808343436, 37486.812565937, 37709.434358485196, 35493.0, 36042.45936310905, 36252.4562131563, 36490.45264320984, 37405.0, 35896.64103359037, 36217.0, 36430.4535431974, 36511.0, 36661.45007824938, 30886.073417797503, 32379.51430728588, 32684.436458021934, 32846.835765821015, 32980.83509582437, 24856.0, 25144.37139071538, 25278.873605631856, 25471.61792573076, 25539.36151596225], "value": 16353.105531642574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.48566778009115, 363.72357008673407, 376.7419317767331, 384.09162331086986, 390.9882703518895, 15598.142102184376, 16544.91727541362, 17403.390881319156, 17606.559836004108, 17629.20668569914, 15746.212689365515, 16154.111523866211, 16802.579935501617, 16907.49277521673, 16990.320387184496, 5058.215976523636, 5183.844484665466, 5190.06578815813, 5226.346706661668, 5229.764660590283, 3712.1647629283466, 5102.1836506159025, 5716.742746576414, 6067.423594758513, 6075.544334174932, 5951.464368206861, 5978.8804223915495, 5984.311804142514, 5991.580589358747, 6010.969945150268, 4884.0, 5200.531952124308, 5205.219217117444, 5208.2968799212, 5209.426963034063, 4536.637069034469, 4854.902901941977, 4855.0, 5034.974825125888, 5042.294078828967, 11857.229280096766, 11960.102992275613, 12098.455569499394, 13132.934335328358, 20177.19291228349, 1818.5726354306728, 1850.501094113772, 2038.98980505098, 2105.95788084239, 2265.9576594766427, 8516.318694504487, 9213.447193168431, 9341.39280946743, 9363.110504502061, 9494.715158545254, 1707.9402220922332, 1709.5127888551826, 1735.9132043397778, 1750.1686698818087, 1788.3383148235237, 68835.0, 68876.0, 69373.95939060969, 69577.30422695758, 70379.64810175968, 9974.251931105196, 9974.351667141758, 9998.350107243152, 10219.335743176669, 10410.115140213014, 14226.573202803933, 14231.50189743354, 14257.073290236309, 14276.357563909649, 14299.714005720036, 7129.0, 7144.749933752294, 7206.423486121098, 7320.450966177558, 7347.70609175627, 6606.768763093365, 6680.231773346128, 6699.397054265042, 6869.141357330333, 6911.723531058802, 4259.829606815692, 4287.571242875688, 4328.177646247203, 4352.891177720519, 4355.390245365651, 1648.8433598808094, 1725.9223334949957, 1764.4882983934515, 1896.6491199128207, 1901.961960760777, 423.75422255091974, 855.3456605696647, 964.4599024546136, 973.6640858903667, 1025.5128813813528, 9230.261579073658, 16214.75677864833, 17056.759215748967, 17146.39987600428, 18216.544586385447, 830.7881490219955, 881.7971866470748, 889.2219308105408, 931.2038207332769, 936.3819878879907, 6353.904691429632, 9217.861732074025, 9588.089131532493, 9696.127348538665, 9707.320487565943, 385355.0, 387496.1875571869, 390887.0, 394123.0, 426805.958212535, 79043.60478197572, 81737.59131204306, 82327.4138068953, 82807.0, 85310.14689853146, 1001.5142655811925, 1001.972977697851, 1012.1700205831148, 1019.1591936652292, 1027.5941003303653, 14914.552563423114, 15093.698126037198, 15107.924460377628, 15151.393944242107, 15161.696766064397, 34130.48804267888, 34395.0, 35225.82387088048, 35631.0, 35661.28677426385, 47235.52764472449, 48568.0, 49452.752736237526, 49856.501434985184, 50593.494065058876, 7695.422843286664, 7882.290593846581, 7888.092869320101, 7896.170902055431, 7955.164707705839, 10699.8930010702, 10813.513391897226, 11154.944225278821, 11327.660170194908, 11446.94276528612, 5769.826905192851, 9781.41311521311, 10172.314074310374, 10206.948965255126, 10472.057514823702, 4907.0, 9830.459324737209, 10215.02957219063, 10258.333208341433, 10590.940905909347, 10422.843657344994, 10439.321444106108, 10505.579776808841, 10548.103411210133, 10718.35689858611, 7924.475747085117, 7972.800679983046, 7980.8802867955865, 7999.840003199787, 8119.634616442156, 9637.22902167839, 10386.48067596602, 10594.4702764863, 10710.303830251009, 10714.67855964291], "value": 8063.764058397065, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.5145323410188, 1448.9058211216272, 1563.4293482878745, 1756.2272600055967, 1777.3690339929333, 6694.36403541664, 7423.962880185605, 7429.108506979163, 7628.618569071545, 7649.04386951631, 7591.468597198198, 7630.65662045208, 7651.23487651236, 7655.6937722491175, 7720.498167619101, 2248.2355998960393, 2285.942851428719, 2288.3706980580305, 2289.748127705959, 2292.3695983604475, 2244.2818298144603, 2266.660000999847, 2266.9659955100688, 2280.1791355112146, 2281.9348489616923, 2253.278950735765, 2254.9098036078535, 2281.0305620111385, 2293.461036656393, 2317.8609283443047, 2223.144089525544, 2226.6993955816, 2234.519578290667, 2240.350298413458, 2242.416971587391, 2208.4258092895802, 2215.8227341812617, 2219.5782801267706, 2220.0675716199235, 2226.142934970032, 7571.810704732371, 7757.8448431031065, 7758.573278469682, 7782.844343113163, 7794.2985131338455, 4521.434820647419, 4606.677532572721, 4643.489216186217, 4655.650826188049, 4658.883527911829, 2851.429714057176, 2956.5779757624236, 3012.8794848206044, 3050.435669401168, 3056.5415187721796, 994.2741798487073, 998.6454808543008, 999.5551979369184, 1013.7212266626663, 1022.0035465421229, 10672.306300090548, 10720.946395268053, 10791.244612877103, 10799.0, 10819.459027048695, 4183.686223533186, 4266.0827921996915, 4332.935005974913, 4428.13651337986, 4447.155040542287, 9182.770430739285, 9214.216791572657, 9249.0, 9265.397749146285, 9283.257339412965, 4738.123447162217, 4738.8341408050555, 4747.335373047776, 4753.904921901542, 4772.0, 3713.090292878262, 4253.787310634518, 4295.033617436052, 4331.198728235224, 4394.2749446340995, 3730.869419570302, 3761.32296186689, 3777.7355585109326, 3820.834645433114, 3830.1190726132586, 1243.0676992255808, 1245.4022069406735, 1262.5896583610363, 1267.0876968582606, 1273.1724379153625, 849.1254008371387, 854.5855260198798, 864.3992425264506, 870.9303255739652, 992.8014397120605, 7146.32109949554, 7262.927370726331, 7270.16393114788, 7276.63616819157, 7294.525855819355, 933.5658918602883, 1013.2248829645328, 1042.7758032023, 1089.1341383600056, 1094.3324572011068, 5594.049011668027, 5722.170285308607, 5733.598648094593, 5734.799282025193, 5762.971185144047, 8904.109589041043, 9248.445093294424, 9626.614935402646, 9699.466529340954, 9786.217102631772, 9447.291453140904, 9459.337846350689, 9462.0, 9472.715818525456, 9515.0, 6984.2317345092, 7160.57036577807, 7233.746818861315, 7235.493515453973, 7332.23011583776, 7294.817629559304, 7350.228226036189, 7410.6665200065045, 7440.888386674096, 7490.438217133846, 8826.823463530822, 8913.197812196673, 8965.058668839938, 8999.685011024583, 9160.587773550073, 8847.20375166238, 8929.687460938836, 9198.080191980749, 9243.39917905361, 9249.630014799603, 6531.771388001397, 7202.423806095605, 7289.5261807982315, 7468.477206595486, 7486.850262994819, 7481.102267727908, 7536.359409450258, 7547.320741133324, 7580.090389153116, 7652.540847548942, 6672.199336079701, 6740.2248741393405, 6816.216135144522, 6861.862762744817, 6925.861482770417, 6483.189601299838, 6505.869882602226, 6523.151990241238, 6597.637129957707, 6628.07206991012, 6702.899456508254, 7239.855202895807, 7295.379892709179, 7346.228645992308, 7346.77959661211, 6600.669966501751, 6630.071789949508, 6655.600663960178, 6679.098321726505, 6681.69932353055, 6425.614463132227, 6496.0255961606135, 6497.545171837926, 6506.4469520091325, 6517.8696426072165], "value": 4468.090683368657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.9671136175021, 301.19130135585954, 305.58135354564234, 306.7132231363675, 307.55097557565955, 5120.539151476366, 5218.817341393052, 5297.576193904488, 5387.811426600069, 5391.622586418952, 5213.661112027716, 5255.947440525593, 5275.6043296752705, 5279.260903473517, 5315.893682126355, 3810.428435734634, 3921.1177485065773, 4037.8586749463775, 4051.561695598057, 4061.3501839705655, 4029.355303151496, 4038.172174704179, 4038.232735780207, 4040.696947728917, 4058.0666446717273, 4006.596042374581, 4008.198360327946, 4008.5748122385976, 4016.5180178378637, 4019.658329042035, 3789.3558095123894, 4008.1582867597695, 4009.6391324780766, 4010.4585880905997, 4018.2566225248424, 3444.844981975792, 3447.413939630269, 3457.135716070982, 3458.1354661334667, 3467.271872906693, 5024.115956516306, 5029.396472423333, 5034.89930201394, 5039.168537191359, 5081.5426611605135, 4568.5431456854385, 4574.0851829633875, 4581.244094724367, 4583.610393116589, 4585.426821647294, 5387.380451248078, 5497.505224529771, 5523.751431185607, 5526.309211348582, 5530.861728456781, 3753.7560058596105, 3779.1496913194587, 3783.3568293389912, 3785.1483416231404, 3789.3747531657245, 5768.394318596529, 5783.392743761887, 5820.0, 5829.154772557998, 5846.50304724099, 3726.7018638508853, 3885.417187421909, 3890.7860067696547, 3891.0855948851995, 3906.374980003186, 3912.8630497933004, 3945.881623551298, 3947.684185265172, 3954.5056867891512, 3956.5252169739815, 4525.411696479437, 4574.336721175411, 4584.243599805995, 4588.885277868013, 4589.380433641482, 5388.353397592314, 5532.363778165482, 5550.611457197957, 5582.860428489239, 5586.55307575393, 1367.6375760423496, 1374.2098293481288, 1382.8893688504895, 1388.7430825297351, 1392.3595146232847, 875.1205038935828, 895.5029958373166, 897.7261935109724, 900.8018235988203, 919.5769945824995, 4652.930206046912, 4665.790039448233, 4877.292792545061, 4898.093852637274, 4910.116179087727, 5743.655380677173, 5771.192033115367, 5797.057985574796, 5799.18811366409, 5804.622699524602, 4633.86098417048, 4891.51084891508, 4900.583450406684, 4906.803727850917, 4909.926351104737, 3034.908952731377, 3081.7226449619193, 3097.2102113960796, 3101.9379612407624, 3102.146909599878, 5409.323834520685, 5456.645318054393, 5459.563234941195, 5461.5357694596405, 5471.261379713687, 5768.010036537388, 5872.882542349214, 5913.142594323799, 5928.555358348141, 5931.1992880960515, 5387.919181212285, 5431.4840090191365, 5443.7822487100075, 5444.0, 5459.590530710213, 5582.106862901916, 5729.885402292014, 5738.540916726568, 5775.595708300379, 5786.710664466676, 5655.8249201979725, 5681.630694004876, 5692.0, 5700.942990570207, 5704.914426283526, 5359.124306492697, 5390.27231323782, 5407.242985981887, 5411.864703382447, 5434.83695489136, 3845.8077995821386, 3868.129670824042, 3880.4955355803563, 3935.4490371348606, 3955.821988010604, 5698.0598201296325, 5701.629394089371, 5710.801341483641, 5711.257536520226, 5734.283214598176, 5532.446755324436, 5561.805336813192, 5576.832695019156, 5578.665280083208, 5579.553635709215, 5250.50120238592, 5564.081926482085, 5566.916496252478, 5576.275084239023, 5580.441955804387, 5400.378956419905, 5429.375621803543, 5436.429174936733, 5446.945530544644, 5481.588880833874, 5288.620120945667, 5383.784648614168, 5539.667619942817, 5557.3331200256225, 5582.720863956704, 5343.385510666168, 5409.107497263065, 5414.35027796667, 5415.945840541544, 5437.238786569805], "value": 4121.705115347538, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.6003367962383, 661.5137873662859, 737.3327138939262, 756.8183635927372, 788.5229436191104, 11608.825867611993, 12337.136400451973, 12554.937225313872, 12962.351882405888, 12999.220046797187, 13179.6705082373, 13293.933530332359, 13368.264745438997, 13372.598822035354, 13375.464981400757, 818.6111596991441, 822.3791037766508, 831.6756464978663, 833.3458235285302, 833.4499230507867, 806.7741032510907, 810.4165001199157, 813.4021494201756, 814.3932770086294, 819.2422009641058, 863.0678866823815, 863.2101627011277, 863.6804382378498, 864.3085531574746, 869.0180096490957, 849.7748096754365, 861.7070196133313, 862.9956850215772, 863.2144748279068, 863.2964134230582, 617.1360095865779, 628.0202883501752, 630.0643544336656, 630.6216270237867, 632.7121159872247, 12814.551490697873, 12834.743305133845, 12838.871611283861, 12845.486180552767, 12887.548935787296, 11852.525898964032, 12083.758324833541, 12118.454669539891, 12217.083718721131, 13502.864971350356, 8776.210141087333, 8780.780480487974, 8899.466032038034, 8969.551522423853, 9085.318601104878, 3279.262166012628, 3332.600087989457, 3341.8496167672515, 3351.145457908218, 3393.8472768725464, 41325.58674413277, 41449.378259326135, 43255.35116973248, 47672.0, 48077.27884081707, 9279.211267042241, 9284.25725941923, 9347.298952578583, 9411.482368469662, 9512.953575106732, 16703.331866725195, 16894.070826104435, 16960.406385776438, 16967.0, 17004.65990680204, 6646.833829154213, 6659.034440006172, 6706.329367063352, 6723.562968407038, 6851.623160726208, 3724.1248306647917, 3792.981035094807, 3827.5789663137034, 3839.3856982882603, 3874.2057878134915, 2700.2574292069444, 2819.4783964966546, 3208.7914285571364, 3345.2640419107756, 3350.7319414447275, 551.9944800551943, 559.560744815318, 560.8009156749376, 574.5116650846746, 583.877385748989, 524.4781442464772, 583.5944018906904, 600.4145957691303, 614.7295190116334, 615.6952308607179, 7630.923690763132, 7707.113681926538, 7889.526628402315, 8051.2351326623875, 8057.6776928923355, 591.2963573347703, 591.7810410148272, 619.7768803230833, 623.4357906094991, 643.7521554201666, 3626.854925802991, 3660.5707094415525, 3693.3351996640863, 3846.2692088503095, 3852.3643598805884, 46958.76520617375, 49903.0, 49943.25085123726, 50413.747931260106, 50685.0, 44478.33282500765, 45001.549984500394, 45176.0, 45668.0, 45690.31464528035, 38915.0, 39710.20579588392, 40153.39769903395, 40836.0, 42231.15537689229, 7163.570185788869, 7189.245129261352, 7211.1707153678, 7229.385502232369, 7340.412766978736, 26908.59637105406, 27473.587896181172, 28214.0, 28274.0, 28385.432291353645, 33238.66761332356, 35974.64025359713, 36338.09154771152, 36481.81759091187, 36620.45069323909, 8521.786955325919, 8588.613512392083, 8600.698975535826, 8651.6106775194, 8678.132186781271, 9939.900600993897, 9986.850197247193, 10132.74668133273, 10266.486675666336, 10366.712976381948, 8800.47197168172, 9680.661176858775, 10816.67549973502, 10895.727606809893, 10975.670729878117, 9708.805823883342, 9798.804023919623, 9959.0, 10974.0, 11172.106231501299, 9547.0, 9562.95218523903, 9799.804003920024, 10159.542820572944, 10868.293560918515, 8898.421602596069, 8947.642094316154, 9047.5482175615, 9360.0, 9471.763205919631, 8155.184481551797, 9275.86086208694, 9348.439093654402, 9353.204977576983, 9357.01751316102], "value": 5796.691556254375, "unit": "score"}], "name": "dromaeo_css", "value": 6342.217704810943, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 113.0, 115.0, 114.0, 127.0, 113.0, 112.0, 113.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 137.0, 162.0, 192.0, 138.0, 155.0, 158.0, 134.0, 204.0, 136.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 172.0, 162.0, 162.0, 164.0, 165.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 160.0, 75.0, 76.0, 76.0, 73.0, 157.0, 75.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 150.0, 94.0, 95.0, 93.0, 141.0, 94.0, 93.0, 145.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 66.0, 68.0, 65.0, 80.0, 63.0, 62.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 63.0, 64.0, 65.0, 64.0, 64.0, 65.0, 63.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 84.0, 84.0, 86.0, 91.0, 87.0, 93.0, 87.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 148.0, 138.0, 150.0, 144.0, 140.0, 138.0, 144.0, 170.0, 140.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 175.0, 177.0, 176.0, 174.0, 179.0, 173.0, 176.0, 175.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 72.0, 73.0, 70.0, 72.0, 72.0, 72.0, 74.0, 72.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1609.7, "alertThreshold": 2.0}]} 22:32:05 INFO - Return code: 0 22:32:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:32:05 ERROR - # TBPL SUCCESS # 22:32:05 INFO - Running post-action listener: _resource_record_post_action 22:32:05 INFO - Running post-run listener: _resource_record_post_run 22:32:07 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 505368576; Read time: 0; Write time: 485424 22:32:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 218923008; Read time: 0; Write time: 268712 22:32:07 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 286445568; Read time: 0; Write time: 216712 22:32:07 INFO - Running post-run listener: _upload_blobber_files 22:32:07 INFO - Blob upload gear active. 22:32:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:32:07 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 22:32:07 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'] 22:32:07 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 22:32:07 INFO - (blobuploader) - INFO - Open directory for files ... 22:32:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:32:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:32:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:08 INFO - (blobuploader) - INFO - Done attempting. 22:32:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:32:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:09 INFO - (blobuploader) - INFO - Done attempting. 22:32:09 INFO - (blobuploader) - INFO - Iteration through files over. 22:32:09 INFO - Return code: 0 22:32:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:32:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:32:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/822dca67ba7eb1f3fcc5cf00ceaa8da022fe683be156bc8482dbbb6744ebb8387f331cc022a6854359d145082cc0d069f68ed2372ddf4c995a0a43fcf4fb6724", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8fb2ddc2542967452915cb65111b92efb8a6d91709fe6184d1911387f966d1c79343e309794dbcba143c44b882ec2657a677b22deac1e2a6162a9a5c2903c9a"} 22:32:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:32:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:32:09 INFO - Contents: 22:32:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/822dca67ba7eb1f3fcc5cf00ceaa8da022fe683be156bc8482dbbb6744ebb8387f331cc022a6854359d145082cc0d069f68ed2372ddf4c995a0a43fcf4fb6724", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8fb2ddc2542967452915cb65111b92efb8a6d91709fe6184d1911387f966d1c79343e309794dbcba143c44b882ec2657a677b22deac1e2a6162a9a5c2903c9a"} 22:32:09 INFO - Running post-run listener: copy_logs_to_upload_dir 22:32:09 INFO - Copying logs to upload dir... 22:32:09 INFO - mkdir: /builds/slave/test/build/upload/logs 22:32:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.001281 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-11 22:32:09.464774) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 22:32:09.472427) ========= 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=7de08804244eb36560b44971000001c3-1460437819.555109-1359500604 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/822dca67ba7eb1f3fcc5cf00ceaa8da022fe683be156bc8482dbbb6744ebb8387f331cc022a6854359d145082cc0d069f68ed2372ddf4c995a0a43fcf4fb6724", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8fb2ddc2542967452915cb65111b92efb8a6d91709fe6184d1911387f966d1c79343e309794dbcba143c44b882ec2657a677b22deac1e2a6162a9a5c2903c9a"} build_url:https://queue.taskcluster.net/v1/task/FEgYkqgHT4eAqtUnWwbDIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/FEgYkqgHT4eAqtUnWwbDIw/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/822dca67ba7eb1f3fcc5cf00ceaa8da022fe683be156bc8482dbbb6744ebb8387f331cc022a6854359d145082cc0d069f68ed2372ddf4c995a0a43fcf4fb6724", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8fb2ddc2542967452915cb65111b92efb8a6d91709fe6184d1911387f966d1c79343e309794dbcba143c44b882ec2657a677b22deac1e2a6162a9a5c2903c9a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 22:32:09.499414) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 22:32:09.499717) ========= 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=7de08804244eb36560b44971000001c3-1460437819.555109-1359500604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 22:32:09.581138) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 22:32:09.581457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 22:32:09.581762) ========= ========= Total master_lag: 0.31 =========