builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1460160556.77 results: success (0) buildid: 20160408152746 builduid: b62e47a29d5b4f1d93dbc3aa09ba0fe8 revision: 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.768686) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.769226) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.769557) ========= 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=6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006333 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.794582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.794949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.808793) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.809220) ========= 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=6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004729 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.859982) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.860294) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.860700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:16.861021) ========= 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=6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-08 17:09:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-04-08 17:09:17 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.606849 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:17.480773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:17.481138) ========= 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=6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014487 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:17.530486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 17:09:17.530878) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae --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=6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-08 17:09:18,100 truncating revision to first 12 chars 2016-04-08 17:09:18,100 Setting DEBUG logging. 2016-04-08 17:09:18,100 attempt 1/10 2016-04-08 17:09:18,100 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/705c5fb32d49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 17:09:19,016 unpacking tar archive at: mozilla-central-705c5fb32d49/testing/mozharness/ program finished with exit code 0 elapsedTime=1.751577 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 17:09:19.295513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:19.295886) ========= echo 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'705c5fb32d49de2c09b564aa5ff8e8edf1be85ae'] 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=6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae program finished with exit code 0 elapsedTime=0.003702 script_repo_revision: '705c5fb32d49de2c09b564aa5ff8e8edf1be85ae' ========= master_lag: 0.21 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:19.504959) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:19.505283) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 17:09:19.520069) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-08 17:09:19.520410) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:09:20 INFO - MultiFileLogger online at 20160408 17:09:20 in /builds/slave/test 17:09:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:09:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:20 INFO - {'append_to_log': False, 17:09:20 INFO - 'base_work_dir': '/builds/slave/test', 17:09:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:09:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:20 INFO - 'branch': 'Firefox-Non-PGO', 17:09:20 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:20 INFO - 'config_files': ('talos/linux_config.py',), 17:09:20 INFO - 'default_actions': ('clobber', 17:09:20 INFO - 'read-buildbot-config', 17:09:20 INFO - 'download-and-extract', 17:09:20 INFO - 'populate-webroot', 17:09:20 INFO - 'create-virtualenv', 17:09:20 INFO - 'install', 17:09:20 INFO - 'run-tests'), 17:09:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:20 INFO - 'download_minidump_stackwalk': True, 17:09:20 INFO - 'download_symbols': 'ondemand', 17:09:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:20 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:20 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:20 INFO - 'installer_path': 'installer.exe', 17:09:20 INFO - 'log_level': 'info', 17:09:20 INFO - 'log_name': 'talos', 17:09:20 INFO - 'log_to_console': True, 17:09:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:09:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:09:20 INFO - 'opt_config_files': (), 17:09:20 INFO - 'pip_index': False, 17:09:20 INFO - 'sps_profile': False, 17:09:20 INFO - 'sps_profile_interval': 0, 17:09:20 INFO - 'suite': 'dromaeojs-e10s', 17:09:20 INFO - 'system_bits': '32', 17:09:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:20 INFO - 'title': 'talos-linux64-ix-050', 17:09:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:20 INFO - 'use_talos_json': True, 17:09:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:20 INFO - 'work_dir': 'build'} 17:09:20 INFO - ##### 17:09:20 INFO - ##### Running clobber step. 17:09:20 INFO - ##### 17:09:20 INFO - Running pre-action listener: _resource_record_pre_action 17:09:20 INFO - Running main action method: clobber 17:09:20 INFO - rmtree: /builds/slave/test/build 17:09:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:20 INFO - Running post-action listener: _resource_record_post_action 17:09:20 INFO - ##### 17:09:20 INFO - ##### Running read-buildbot-config step. 17:09:20 INFO - ##### 17:09:20 INFO - Running pre-action listener: _resource_record_pre_action 17:09:20 INFO - Running main action method: read_buildbot_config 17:09:20 INFO - Using buildbot properties: 17:09:20 INFO - { 17:09:20 INFO - "project": "", 17:09:20 INFO - "product": "firefox", 17:09:20 INFO - "script_repo_revision": "production", 17:09:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:09:20 INFO - "repository": "", 17:09:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:09:20 INFO - "buildid": "20160408152746", 17:09:20 INFO - "pgo_build": "False", 17:09:20 INFO - "basedir": "/builds/slave/test", 17:09:20 INFO - "buildnumber": 310, 17:09:20 INFO - "slavename": "talos-linux64-ix-050", 17:09:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:09:20 INFO - "platform": "ubuntu64_hw", 17:09:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:09:20 INFO - "branch": "mozilla-central", 17:09:20 INFO - "repo_path": "mozilla-central", 17:09:20 INFO - "revision": "705c5fb32d49de2c09b564aa5ff8e8edf1be85ae", 17:09:20 INFO - "stage_platform": "linux64", 17:09:20 INFO - "builduid": "b62e47a29d5b4f1d93dbc3aa09ba0fe8", 17:09:20 INFO - "slavebuilddir": "test" 17:09:20 INFO - } 17:09:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:09:20 INFO - Running post-action listener: _resource_record_post_action 17:09:20 INFO - ##### 17:09:20 INFO - ##### Running download-and-extract step. 17:09:20 INFO - ##### 17:09:20 INFO - Running pre-action listener: _resource_record_pre_action 17:09:20 INFO - Running main action method: download_and_extract 17:09:20 INFO - mkdir: /builds/slave/test/build/tests 17:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:20 INFO - https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:09:21 INFO - Downloaded 1361 bytes. 17:09:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:09:21 INFO - Using the following test package requirements: 17:09:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:09:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:09:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'jsshell-linux-x86_64.zip'], 17:09:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:09:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:09:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:09:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:09:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:09:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:21 INFO - https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:26 INFO - Downloaded 22185985 bytes. 17:09:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:09:28 INFO - Return code: 0 17:09:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:28 INFO - https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:40 INFO - Downloaded 22185985 bytes. 17:09:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:09:41 INFO - Return code: 0 17:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:41 INFO - https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:09:43 INFO - Downloaded 10841097 bytes. 17:09:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:09:44 INFO - Return code: 0 17:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:44 INFO - https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:09:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:09:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:09:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:09:46 INFO - Downloaded 54064538 bytes. 17:09:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:09:46 INFO - mkdir: /builds/slave/test/properties 17:09:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:46 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:46 INFO - Contents: 17:09:46 INFO - build_url:https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:09:48 INFO - Running post-action listener: _resource_record_post_action 17:09:48 INFO - Running post-action listener: set_extra_try_arguments 17:09:48 INFO - ##### 17:09:48 INFO - ##### Running populate-webroot step. 17:09:48 INFO - ##### 17:09:48 INFO - Running pre-action listener: _resource_record_pre_action 17:09:48 INFO - Running main action method: populate_webroot 17:09:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:48 INFO - '--tppagecycles', 17:09:48 INFO - '7'], 17:09:48 INFO - 'tests': ['tsvgm']}}, 17:09:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:09:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:09:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:09:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:09:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:48 INFO - 'talos_options': ['--disable-e10s'], 17:09:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:48 INFO - 'talos_options': ['--disable-e10s'], 17:09:48 INFO - 'tests': ['damp', 'tps']}, 17:09:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:48 INFO - 'tests': ['damp', 'tps']}, 17:09:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:09:48 INFO - 'tests': ['dromaeo_dom']}, 17:09:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:09:48 INFO - 'tests': ['a11yr', 17:09:48 INFO - 'ts_paint', 17:09:48 INFO - 'tpaint', 17:09:48 INFO - 'sessionrestore', 17:09:48 INFO - 'sessionrestore_no_auto_restore', 17:09:48 INFO - 'tabpaint']}, 17:09:48 INFO - 'other-e10s': {'tests': ['a11yr', 17:09:48 INFO - 'ts_paint', 17:09:48 INFO - 'tpaint', 17:09:48 INFO - 'sessionrestore', 17:09:48 INFO - 'sessionrestore_no_auto_restore', 17:09:48 INFO - 'tabpaint']}, 17:09:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:09:48 INFO - 'ts_paint', 17:09:48 INFO - 'tpaint', 17:09:48 INFO - 'sessionrestore', 17:09:48 INFO - 'sessionrestore_no_auto_restore', 17:09:48 INFO - 'tabpaint']}, 17:09:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:09:48 INFO - 'ts_paint', 17:09:48 INFO - 'tpaint', 17:09:48 INFO - 'sessionrestore', 17:09:48 INFO - 'sessionrestore_no_auto_restore', 17:09:48 INFO - 'tabpaint']}, 17:09:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:09:48 INFO - 'tests': ['a11yr', 17:09:48 INFO - 'ts_paint', 17:09:48 INFO - 'tpaint', 17:09:48 INFO - 'sessionrestore', 17:09:48 INFO - 'sessionrestore_no_auto_restore', 17:09:48 INFO - 'tabpaint']}, 17:09:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:09:48 INFO - 'tests': ['a11yr', 17:09:48 INFO - 'ts_paint', 17:09:48 INFO - 'tpaint', 17:09:48 INFO - 'sessionrestore', 17:09:48 INFO - 'sessionrestore_no_auto_restore', 17:09:48 INFO - 'tabpaint']}, 17:09:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:09:48 INFO - 'tests': ['tsvgx', 17:09:48 INFO - 'tsvgr_opacity', 17:09:48 INFO - 'tart', 17:09:48 INFO - 'tscrollx', 17:09:48 INFO - 'cart']}, 17:09:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:09:48 INFO - 'tsvgr_opacity', 17:09:48 INFO - 'tart', 17:09:48 INFO - 'tscrollx', 17:09:48 INFO - 'cart']}, 17:09:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:48 INFO - 'talos_options': ['--disable-e10s'], 17:09:48 INFO - 'tests': ['tp5o']}, 17:09:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:48 INFO - 'tests': ['tp5o']}, 17:09:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:48 INFO - 'talos_options': ['--disable-e10s', 17:09:48 INFO - '--xperf_path', 17:09:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:48 INFO - 'tests': ['tp5n']}, 17:09:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:48 INFO - 'talos_options': ['--xperf_path', 17:09:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:48 INFO - 'tests': ['tp5n']}}, 17:09:48 INFO - 'talos.zip': {'path': '', 17:09:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:48 INFO - Running post-action listener: _resource_record_post_action 17:09:48 INFO - ##### 17:09:48 INFO - ##### Running create-virtualenv step. 17:09:48 INFO - ##### 17:09:48 INFO - Running pre-action listener: _resource_record_pre_action 17:09:48 INFO - Running main action method: create_virtualenv 17:09:48 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:09:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:48 INFO - Using real prefix '/usr' 17:09:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:48 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:50 INFO - Installing pip.................done. 17:09:50 INFO - Return code: 0 17:09:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7425904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b410>, '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 0x124c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09: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', 'pip>=1.5'] in /builds/slave/test/build 17:09: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 pip>=1.5 17:09:50 INFO - Using env: {'DISPLAY': ':0', 17:09:50 INFO - 'HOME': '/home/cltbld', 17:09:50 INFO - 'LANG': 'en_US.UTF-8', 17:09:50 INFO - 'LANGUAGE': 'en_US:en', 17:09:50 INFO - 'LOGNAME': 'cltbld', 17:09:50 INFO - 'MAIL': '/var/mail/cltbld', 17:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:50 INFO - 'MOZ_NO_REMOTE': '1', 17:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:50 INFO - 'NO_EM_RESTART': '1', 17:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:50 INFO - 'PWD': '/builds/slave/test', 17:09:50 INFO - 'SHELL': '/bin/bash', 17:09:50 INFO - 'SHLVL': '1', 17:09:50 INFO - 'TERM': 'linux', 17:09:50 INFO - 'TMOUT': '86400', 17:09:50 INFO - 'USER': 'cltbld', 17:09:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 17:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:50 INFO - '_': '/tools/buildbot/bin/python'} 17:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:09:51 INFO - Cleaning up... 17:09:51 INFO - Return code: 0 17:09:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:51 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 0x7f7425904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b410>, '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 0x124c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:09:51 INFO - Using env: {'DISPLAY': ':0', 17:09:51 INFO - 'HOME': '/home/cltbld', 17:09:51 INFO - 'LANG': 'en_US.UTF-8', 17:09:51 INFO - 'LANGUAGE': 'en_US:en', 17:09:51 INFO - 'LOGNAME': 'cltbld', 17:09:51 INFO - 'MAIL': '/var/mail/cltbld', 17:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:51 INFO - 'MOZ_NO_REMOTE': '1', 17:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:51 INFO - 'NO_EM_RESTART': '1', 17:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:51 INFO - 'PWD': '/builds/slave/test', 17:09:51 INFO - 'SHELL': '/bin/bash', 17:09:51 INFO - 'SHLVL': '1', 17:09:51 INFO - 'TERM': 'linux', 17:09:51 INFO - 'TMOUT': '86400', 17:09:51 INFO - 'USER': 'cltbld', 17:09:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 17:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:51 INFO - '_': '/tools/buildbot/bin/python'} 17:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:51 INFO - Downloading/unpacking psutil>=0.7.1 17:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:56 INFO - Installing collected packages: psutil 17:09:56 INFO - Running setup.py install for psutil 17:09:56 INFO - building 'psutil._psutil_linux' extension 17:09:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:09:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:09:56 INFO - building 'psutil._psutil_posix' extension 17:09:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:09:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:09:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:56 INFO - Successfully installed psutil 17:09:56 INFO - Cleaning up... 17:09:56 INFO - Return code: 0 17:09:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:56 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 0x7f7425904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b410>, '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 0x124c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:09:56 INFO - Using env: {'DISPLAY': ':0', 17:09:56 INFO - 'HOME': '/home/cltbld', 17:09:56 INFO - 'LANG': 'en_US.UTF-8', 17:09:56 INFO - 'LANGUAGE': 'en_US:en', 17:09:56 INFO - 'LOGNAME': 'cltbld', 17:09:56 INFO - 'MAIL': '/var/mail/cltbld', 17:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:56 INFO - 'MOZ_NO_REMOTE': '1', 17:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:56 INFO - 'NO_EM_RESTART': '1', 17:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:56 INFO - 'PWD': '/builds/slave/test', 17:09:56 INFO - 'SHELL': '/bin/bash', 17:09:56 INFO - 'SHLVL': '1', 17:09:56 INFO - 'TERM': 'linux', 17:09:56 INFO - 'TMOUT': '86400', 17:09:56 INFO - 'USER': 'cltbld', 17:09:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 17:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:56 INFO - '_': '/tools/buildbot/bin/python'} 17:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:10:01 INFO - Installing collected packages: mozsystemmonitor 17:10:01 INFO - Running setup.py install for mozsystemmonitor 17:10:01 INFO - Successfully installed mozsystemmonitor 17:10:01 INFO - Cleaning up... 17:10:01 INFO - Return code: 0 17:10:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7425904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b410>, '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 0x124c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:10:01 INFO - Using env: {'DISPLAY': ':0', 17:10:01 INFO - 'HOME': '/home/cltbld', 17:10:01 INFO - 'LANG': 'en_US.UTF-8', 17:10:01 INFO - 'LANGUAGE': 'en_US:en', 17:10:01 INFO - 'LOGNAME': 'cltbld', 17:10:01 INFO - 'MAIL': '/var/mail/cltbld', 17:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:01 INFO - 'MOZ_NO_REMOTE': '1', 17:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:01 INFO - 'NO_EM_RESTART': '1', 17:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:01 INFO - 'PWD': '/builds/slave/test', 17:10:01 INFO - 'SHELL': '/bin/bash', 17:10:01 INFO - 'SHLVL': '1', 17:10:01 INFO - 'TERM': 'linux', 17:10:01 INFO - 'TMOUT': '86400', 17:10:01 INFO - 'USER': 'cltbld', 17:10:01 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 17:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:01 INFO - '_': '/tools/buildbot/bin/python'} 17:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:01 INFO - Downloading/unpacking blobuploader==1.2.4 17:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:04 INFO - Downloading blobuploader-1.2.4.tar.gz 17:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:10:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:10:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10:05 INFO - Downloading docopt-0.6.1.tar.gz 17:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:10:05 INFO - Installing collected packages: blobuploader, requests, docopt 17:10:05 INFO - Running setup.py install for blobuploader 17:10:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:10:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:10:05 INFO - Running setup.py install for requests 17:10:06 INFO - Running setup.py install for docopt 17:10:06 INFO - Successfully installed blobuploader requests docopt 17:10:06 INFO - Cleaning up... 17:10:06 INFO - Return code: 0 17:10:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:06 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 0x7f7425904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b410>, '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 0x124c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:10:06 INFO - Using env: {'DISPLAY': ':0', 17:10:06 INFO - 'HOME': '/home/cltbld', 17:10:06 INFO - 'LANG': 'en_US.UTF-8', 17:10:06 INFO - 'LANGUAGE': 'en_US:en', 17:10:06 INFO - 'LOGNAME': 'cltbld', 17:10:06 INFO - 'MAIL': '/var/mail/cltbld', 17:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:06 INFO - 'MOZ_NO_REMOTE': '1', 17:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:06 INFO - 'NO_EM_RESTART': '1', 17:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:06 INFO - 'PWD': '/builds/slave/test', 17:10:06 INFO - 'SHELL': '/bin/bash', 17:10:06 INFO - 'SHLVL': '1', 17:10:06 INFO - 'TERM': 'linux', 17:10:06 INFO - 'TMOUT': '86400', 17:10:06 INFO - 'USER': 'cltbld', 17:10:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 17:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:06 INFO - '_': '/tools/buildbot/bin/python'} 17:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:06 INFO - Running setup.py (path:/tmp/pip-4JJ8Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:06 INFO - Running setup.py (path:/tmp/pip-AO0ram-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:06 INFO - Running setup.py (path:/tmp/pip-RNPLgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:06 INFO - Running setup.py (path:/tmp/pip-SuSfjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:06 INFO - Running setup.py (path:/tmp/pip-A8baPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:06 INFO - Running setup.py (path:/tmp/pip-ELfN1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:06 INFO - Running setup.py (path:/tmp/pip-m6Uu3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:06 INFO - Running setup.py (path:/tmp/pip-_tF6Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:06 INFO - Running setup.py (path:/tmp/pip-0H4Oul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:07 INFO - Running setup.py (path:/tmp/pip-jXMrOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:07 INFO - Running setup.py (path:/tmp/pip-xCwscj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:07 INFO - Running setup.py (path:/tmp/pip-yVGoi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:07 INFO - Running setup.py (path:/tmp/pip-_ZkWDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:07 INFO - Running setup.py (path:/tmp/pip-7303ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:07 INFO - Running setup.py (path:/tmp/pip-zTmDlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:07 INFO - Running setup.py (path:/tmp/pip-Oxt6HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:07 INFO - Running setup.py (path:/tmp/pip-5IlD_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:10:07 INFO - Running setup.py install for manifestparser 17:10:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:10:07 INFO - Running setup.py install for mozcrash 17:10:07 INFO - Running setup.py install for mozdebug 17:10:07 INFO - Running setup.py install for mozdevice 17:10:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Running setup.py install for mozfile 17:10:08 INFO - Running setup.py install for mozhttpd 17:10:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Running setup.py install for mozinfo 17:10:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Running setup.py install for mozInstall 17:10:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Running setup.py install for mozleak 17:10:08 INFO - Running setup.py install for mozlog 17:10:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Running setup.py install for moznetwork 17:10:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Running setup.py install for mozprocess 17:10:08 INFO - Running setup.py install for mozprofile 17:10:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:10:09 INFO - Running setup.py install for mozrunner 17:10:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:10:09 INFO - Running setup.py install for mozscreenshot 17:10:09 INFO - Running setup.py install for moztest 17:10:09 INFO - Running setup.py install for mozversion 17:10:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:10:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:10:09 INFO - Cleaning up... 17:10:09 INFO - Return code: 0 17:10:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:09 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 0x7f7425904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b410>, '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 0x124c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:10:09 INFO - Using env: {'DISPLAY': ':0', 17:10:09 INFO - 'HOME': '/home/cltbld', 17:10:09 INFO - 'LANG': 'en_US.UTF-8', 17:10:09 INFO - 'LANGUAGE': 'en_US:en', 17:10:09 INFO - 'LOGNAME': 'cltbld', 17:10:09 INFO - 'MAIL': '/var/mail/cltbld', 17:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:09 INFO - 'MOZ_NO_REMOTE': '1', 17:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:09 INFO - 'NO_EM_RESTART': '1', 17:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:09 INFO - 'PWD': '/builds/slave/test', 17:10:09 INFO - 'SHELL': '/bin/bash', 17:10:09 INFO - 'SHLVL': '1', 17:10:09 INFO - 'TERM': 'linux', 17:10:09 INFO - 'TMOUT': '86400', 17:10:09 INFO - 'USER': 'cltbld', 17:10:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 17:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:09 INFO - '_': '/tools/buildbot/bin/python'} 17:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:09 INFO - Running setup.py (path:/tmp/pip-pYxZak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:09 INFO - Running setup.py (path:/tmp/pip-h168Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:09 INFO - Running setup.py (path:/tmp/pip-q2aSV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:09 INFO - Running setup.py (path:/tmp/pip-78WwvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:09 INFO - Running setup.py (path:/tmp/pip-lsZLv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:10 INFO - Running setup.py (path:/tmp/pip-ZpY1GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:10 INFO - Running setup.py (path:/tmp/pip-9trsVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:10 INFO - Running setup.py (path:/tmp/pip-I0iJT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:10 INFO - Running setup.py (path:/tmp/pip-uheEMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:10 INFO - Running setup.py (path:/tmp/pip-DiiXtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:10 INFO - Running setup.py (path:/tmp/pip-wgp0E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:10 INFO - Running setup.py (path:/tmp/pip-42OkCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:10 INFO - Running setup.py (path:/tmp/pip-Rbqhdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:10 INFO - Running setup.py (path:/tmp/pip-05aP2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:10 INFO - Running setup.py (path:/tmp/pip-fc0baG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:10 INFO - Running setup.py (path:/tmp/pip-gkFCvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:10 INFO - Running setup.py (path:/tmp/pip-Lr9kbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:10:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:15 INFO - Downloading blessings-1.6.tar.gz 17:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:15 INFO - Installing collected packages: blessings 17:10:15 INFO - Running setup.py install for blessings 17:10:15 INFO - Successfully installed blessings 17:10:15 INFO - Cleaning up... 17:10:15 INFO - Return code: 0 17:10:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:15 INFO - Reading from file tmpfile_stdout 17:10:15 INFO - Current package versions: 17:10:15 INFO - argparse == 1.2.1 17:10:15 INFO - blessings == 1.6 17:10:15 INFO - blobuploader == 1.2.4 17:10:15 INFO - docopt == 0.6.1 17:10:15 INFO - manifestparser == 1.1 17:10:15 INFO - mozInstall == 1.12 17:10:15 INFO - mozcrash == 0.17 17:10:15 INFO - mozdebug == 0.1 17:10:15 INFO - mozdevice == 0.48 17:10:15 INFO - mozfile == 1.2 17:10:15 INFO - mozhttpd == 0.7 17:10:15 INFO - mozinfo == 0.9 17:10:15 INFO - mozleak == 0.1 17:10:15 INFO - mozlog == 3.1 17:10:15 INFO - moznetwork == 0.27 17:10:15 INFO - mozprocess == 0.22 17:10:15 INFO - mozprofile == 0.28 17:10:15 INFO - mozrunner == 6.11 17:10:15 INFO - mozscreenshot == 0.1 17:10:15 INFO - mozsystemmonitor == 0.0 17:10:15 INFO - moztest == 0.7 17:10:15 INFO - mozversion == 1.4 17:10:15 INFO - psutil == 3.1.1 17:10:15 INFO - requests == 1.2.3 17:10:15 INFO - wsgiref == 0.1.2 17:10:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:15 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 0x7f7425904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b410>, '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 0x124c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:10:15 INFO - Using env: {'DISPLAY': ':0', 17:10:15 INFO - 'HOME': '/home/cltbld', 17:10:15 INFO - 'LANG': 'en_US.UTF-8', 17:10:15 INFO - 'LANGUAGE': 'en_US:en', 17:10:15 INFO - 'LOGNAME': 'cltbld', 17:10:15 INFO - 'MAIL': '/var/mail/cltbld', 17:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:15 INFO - 'MOZ_NO_REMOTE': '1', 17:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:15 INFO - 'NO_EM_RESTART': '1', 17:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:15 INFO - 'PWD': '/builds/slave/test', 17:10:15 INFO - 'SHELL': '/bin/bash', 17:10:15 INFO - 'SHLVL': '1', 17:10:15 INFO - 'TERM': 'linux', 17:10:15 INFO - 'TMOUT': '86400', 17:10:15 INFO - 'USER': 'cltbld', 17:10:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 17:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:15 INFO - '_': '/tools/buildbot/bin/python'} 17:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:10:16 INFO - Cleaning up... 17:10:16 INFO - Return code: 0 17:10:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:16 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 0x7f7425904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b410>, '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 0x124c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:10:16 INFO - Using env: {'DISPLAY': ':0', 17:10:16 INFO - 'HOME': '/home/cltbld', 17:10:16 INFO - 'LANG': 'en_US.UTF-8', 17:10:16 INFO - 'LANGUAGE': 'en_US:en', 17:10:16 INFO - 'LOGNAME': 'cltbld', 17:10:16 INFO - 'MAIL': '/var/mail/cltbld', 17:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:16 INFO - 'MOZ_NO_REMOTE': '1', 17:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:16 INFO - 'NO_EM_RESTART': '1', 17:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:16 INFO - 'PWD': '/builds/slave/test', 17:10:16 INFO - 'SHELL': '/bin/bash', 17:10:16 INFO - 'SHLVL': '1', 17:10:16 INFO - 'TERM': 'linux', 17:10:16 INFO - 'TMOUT': '86400', 17:10:16 INFO - 'USER': 'cltbld', 17:10:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 17:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:16 INFO - '_': '/tools/buildbot/bin/python'} 17:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:16 INFO - Downloading/unpacking jsonschema 17:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:19 INFO - Downloading/unpacking functools32 (from jsonschema) 17:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:10:19 INFO - warning: no files found matching '*.txt' 17:10:19 INFO - no previously-included directories found matching 'build' 17:10:19 INFO - no previously-included directories found matching 'dist' 17:10:19 INFO - no previously-included directories found matching '.git*' 17:10:19 INFO - Installing collected packages: jsonschema, functools32 17:10:19 INFO - Running setup.py install for functools32 17:10:19 INFO - warning: no files found matching '*.txt' 17:10:19 INFO - no previously-included directories found matching 'build' 17:10:19 INFO - no previously-included directories found matching 'dist' 17:10:19 INFO - no previously-included directories found matching '.git*' 17:10:19 INFO - Successfully installed jsonschema functools32 17:10:19 INFO - Cleaning up... 17:10:20 INFO - Return code: 0 17:10:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:20 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 0x7f7425904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b410>, '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 0x124c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:10:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:10:20 INFO - Using env: {'DISPLAY': ':0', 17:10:20 INFO - 'HOME': '/home/cltbld', 17:10:20 INFO - 'LANG': 'en_US.UTF-8', 17:10:20 INFO - 'LANGUAGE': 'en_US:en', 17:10:20 INFO - 'LOGNAME': 'cltbld', 17:10:20 INFO - 'MAIL': '/var/mail/cltbld', 17:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:20 INFO - 'MOZ_NO_REMOTE': '1', 17:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:20 INFO - 'NO_EM_RESTART': '1', 17:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:20 INFO - 'PWD': '/builds/slave/test', 17:10:20 INFO - 'SHELL': '/bin/bash', 17:10:20 INFO - 'SHLVL': '1', 17:10:20 INFO - 'TERM': 'linux', 17:10:20 INFO - 'TMOUT': '86400', 17:10:20 INFO - 'USER': 'cltbld', 17:10:20 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 17:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:20 INFO - '_': '/tools/buildbot/bin/python'} 17:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:20 INFO - Downloading/unpacking flake8 17:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:10:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:10:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:24 INFO - no previously-included directories found matching 'docs/_build' 17:10:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:10:24 INFO - Running setup.py install for pep8 17:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:24 INFO - no previously-included directories found matching 'docs/_build' 17:10:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:10:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:10:24 INFO - Cleaning up... 17:10:24 INFO - Return code: 0 17:10:24 INFO - Running post-action listener: _resource_record_post_action 17:10:24 INFO - Running post-action listener: _start_resource_monitoring 17:10:24 INFO - Starting resource monitoring. 17:10:24 INFO - ##### 17:10:24 INFO - ##### Running install step. 17:10:24 INFO - ##### 17:10:24 INFO - Running pre-action listener: _resource_record_pre_action 17:10:24 INFO - Running main action method: install 17:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:25 INFO - Reading from file tmpfile_stdout 17:10:25 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:10:25 INFO - Reading from file tmpfile_stdout 17:10:25 INFO - Output received: 17:10:25 INFO - Usage: mozinstall [options] installer 17:10:25 INFO - Options: 17:10:25 INFO - -h, --help show this help message and exit 17:10:25 INFO - -d DEST, --destination=DEST 17:10:25 INFO - Directory to install application into. [default: 17:10:25 INFO - "/builds/slave/test"] 17:10:25 INFO - --app=APP Application being installed. [default: firefox] 17:10:25 INFO - mkdir: /builds/slave/test/build/application 17:10:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:10:40 INFO - Reading from file tmpfile_stdout 17:10:40 INFO - Output received: 17:10:40 INFO - /builds/slave/test/build/application/firefox/firefox 17:10:40 INFO - Running post-action listener: _resource_record_post_action 17:10:40 INFO - ##### 17:10:40 INFO - ##### Running run-tests step. 17:10:40 INFO - ##### 17:10:40 INFO - Running pre-action listener: _resource_record_pre_action 17:10:40 INFO - Running main action method: run_tests 17:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:10:40 INFO - Python 2.7.3 17:10:40 INFO - Return code: 0 17:10:40 INFO - grabbing minidump binary from tooltool 17:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:40 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 0x124b410>, '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 0x124c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:10:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:10:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:10:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:40 INFO - Return code: 0 17:10:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:10:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:10:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:10:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:10:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:10:41 INFO - Return code: 0 17:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:10:41 INFO - Using env: {'DISPLAY': ':0', 17:10:41 INFO - 'HOME': '/home/cltbld', 17:10:41 INFO - 'LANG': 'en_US.UTF-8', 17:10:41 INFO - 'LANGUAGE': 'en_US:en', 17:10:41 INFO - 'LOGNAME': 'cltbld', 17:10:41 INFO - 'MAIL': '/var/mail/cltbld', 17:10:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:41 INFO - 'MOZ_NO_REMOTE': '1', 17:10:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:41 INFO - 'NO_EM_RESTART': '1', 17:10:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:41 INFO - 'PWD': '/builds/slave/test', 17:10:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:41 INFO - 'SHELL': '/bin/bash', 17:10:41 INFO - 'SHLVL': '1', 17:10:41 INFO - 'TERM': 'linux', 17:10:41 INFO - 'TMOUT': '86400', 17:10:41 INFO - 'USER': 'cltbld', 17:10:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441', 17:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:41 INFO - '_': '/tools/buildbot/bin/python'} 17:10:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:10:41 INFO - mozversion application_buildid: 20160408152746 17:10:41 INFO - mozversion application_changeset: 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae 17:10:41 INFO - mozversion application_display_name: Nightly 17:10:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:41 INFO - mozversion application_name: Firefox 17:10:41 INFO - mozversion application_remotingname: firefox 17:10:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:10:41 INFO - mozversion application_vendor: Mozilla 17:10:41 INFO - mozversion application_version: 48.0a1 17:10:41 INFO - mozversion platform_buildid: 20160408152746 17:10:41 INFO - mozversion platform_changeset: 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae 17:10:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:10:41 INFO - mozversion platform_version: 48.0a1 17:10:41 INFO - using testdate: 1460160641 17:10:41 INFO - actual date: 1460160641 17:10:41 INFO - starting webserver on 'localhost:35384' 17:10:42 INFO - SUITE-START | Running 2 tests 17:10:42 INFO - TEST-START | dromaeo_css 17:10:42 INFO - operating with platform_type : linux_ 17:10:42 INFO - Initialising browser for dromaeo_css test... 17:10:42 INFO - TEST-INFO | started process 20153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqeaxK3/profile http://localhost:35384/getInfo.html) 17:10:45 INFO - PROCESS | 20153 | 17:10:45 INFO - PROCESS | 20153 | (process:20220): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:10:45 INFO - PROCESS | 20153 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:10:46 INFO - PROCESS | 20153 | __metrics Screen width/height:1600/1200 17:10:46 INFO - PROCESS | 20153 | colorDepth:24 17:10:46 INFO - PROCESS | 20153 | Browser inner width/height: 1024/697 17:10:46 INFO - PROCESS | 20153 | __metrics 17:10:47 ERROR - PROCESS | 20153 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 17:10:47 INFO - TEST-INFO | 20153: exit 0 17:10:47 INFO - Browser initialized. 17:10:47 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:47 INFO - TEST-INFO | started process 20271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqeaxK3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:49 INFO - PROCESS | 20271 | 17:10:49 INFO - PROCESS | 20271 | (process:20333): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:10:59 INFO - PROCESS | 20271 | RSS: Main: 164192256 17:10:59 INFO - PROCESS | 20271 | 17:11:49 INFO - PROCESS | 20271 | 1460160709438 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:14:01 INFO - PROCESS | 20271 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35384/tests/dromaeo/cssquery-ext.html) 17:14:02 INFO - PROCESS | 20271 | RSS: Main: 168722432 17:14:02 INFO - PROCESS | 20271 | 17:17:04 INFO - PROCESS | 20271 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-ext.html (next: http://localhost:35384/tests/dromaeo/cssquery-jquery.html) 17:17:04 INFO - PROCESS | 20271 | RSS: Main: 165388288 17:17:04 INFO - PROCESS | 20271 | 17:20:06 INFO - PROCESS | 20271 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35384/tests/dromaeo/cssquery-mootools.html) 17:20:07 INFO - PROCESS | 20271 | RSS: Main: 166887424 17:20:07 INFO - PROCESS | 20271 | 17:23:09 INFO - PROCESS | 20271 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35384/tests/dromaeo/cssquery-prototype.html) 17:23:09 INFO - PROCESS | 20271 | RSS: Main: 163979264 17:23:09 INFO - PROCESS | 20271 | 17:26:12 INFO - PROCESS | 20271 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35384/tests/dromaeo/cssquery-yui.html) 17:26:12 INFO - PROCESS | 20271 | RSS: Main: 165675008 17:26:12 INFO - PROCESS | 20271 | 17:29:15 INFO - PROCESS | 20271 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-yui.html (next: http://localhost:35384/tests/dromaeo/cssquery-dojo.html) 17:29:15 INFO - PROCESS | 20271 | RSS: Main: 167927808 17:29:15 INFO - PROCESS | 20271 | 17:29:15 INFO - PROCESS | 20271 | __start_tp_report 17:29:15 INFO - PROCESS | 20271 | _x_x_mozilla_page_load 17:29:15 INFO - PROCESS | 20271 | _x_x_mozilla_page_load_details 17:29:15 INFO - PROCESS | 20271 | |i|pagename|runs| 17:29:15 INFO - PROCESS | 20271 | |0;dojo.html;2631.486860062288;2672.839629622222;2704.2563295093832;2710.024391219161;2715.5247831629486;4618.16872962867;4632.143053535098;4662.277347011214;4671.649626278034;4703.670743047988;4618.861434156972;4697.318888761128;4764.237721964487;4777.331173635694;4781.737004464761;4296.871093867181;4326.524082350938;4371.060222052258;4386.078923426068;4418.64650827933;4347.347897815337;4387.23223435899;4421.491528474218;4433.046894917592;4436.334549817521;4236.68224883135;4282.4004639350205;4300.032492689135;4337.761423121727;4355.825766969318;4347.152305300468;4358.520562738128;4365.476142862877;4366;4376.277914144162;4339.435873336478;4339.5443478434945;4344.391785150082;4346.15250026245;4399.626031787302;4510.571495707935;4581;4634.86095417138;4651.744154071558;4651.86044418668;4994.700317980933;5016.523430274118;5017.974910125426;5036.622253331015;5082.949170508322;5057.69653820772;5060.797568097271;5063.569596584295;5066.316047333599;5136.152534831748;4580.083983203339;4663.930041049353;4724.149653062482;4739.597134243628;4748.527956333548;5127.359080114986;5146.25379320004;5160.458151893997;5164.92252616211;5186.974065129651;4916.8770780730765;4932.3022199323295;4940.802367905316;4959.429665588504;4959.628027897922;4890.926636100461;4978.303037574742;4994.825181118644;5066.493350664904;5074.06129865976;4851.320815085891;4932.580730637936;4935.062338155739;4940.505949405103;4942.20924652054;4899.951000490021;4903.313536104948;4905.607551395879;4973.975130124326;5039.3448851649055;4229.851955181553;4259.361095835588;4261.169072030924;4270.935935960963;4305.6986010978935;3621.9818900905852;3644.6173151819207;3721.106934335794;3749.7937613431523;3760.304343696425;4423.800928958204;4433.423654924839;4435.889102772392;4460.107978404332;4479.372887795711;4997.075541024922;5057.595392368602;5077.213031980049;5085.389753229636;5149.510796474329;4327.221100201931;4392.714473559208;4421.867343979686;4464.285714285698;4475.239209334421;4527.230370836965;4535.183666939983;4536.432945881765;4540.614047805973;4585.472670642852;4707;4735.337052812678;4739.052189562032;4749.192637251606;4802.207635740064;4891.070696567641;5023.522765337287;5068.82259120929;5099.617528685438;5143.897122057463;4683.578477936866;4734.526547345238;4735.976320118515;4738.952610473852;4772.880677983078;4843.104025755247;4951.752412379438;4953.826616068421;4964.205727083649;5021.07110184617;5007.7245751484015;5015.22264049073;5023.6985780853265;5073.695578265316;5077.162268225849;4844.442889067803;4870.7808148632685;4871.561559459666;4877.341558889647;4924.532169443897;4772.665913386029;4810.206315957827;4819.903601927872;4832.867897947345;4922.1632322505975;4741.146593613183;4809.110314591811;4810.230363142021;4823.903521929612;4834.540718631724;4884.413870335582;4901.387326584177;4906.730129842893;4916.901661966812;4959.107360675113;4672.48602653701;4809.0862736080035;4822.035592881368;4827.782749776339;4867.975660121677 17:29:15 INFO - PROCESS | 20271 | |1;ext.html;557.6431084106173;590.5128269177928;592.2419303291788;607.2712744706353;623.9625622462655;25975.350616234602;32513.837430812844;33514.32971340578;33554.832225838894;33676.494852577234;37732.81133594328;38807.223855522876;38923.026924326834;39366.21267574654;39382.80308598453;7701.845963080735;7880.330171935392;7892.131865494791;7899.763007109767;7899.960500197491;7684.615769211545;7805.843883122334;7812.3359514441345;7831.2560306770765;7841.568713720743;7853.842923141562;7895.131535531087;7915.050193976731;7922.405819563527;7931.286184243417;7816.648250828726;7820.804479888048;7829.138794732575;7864;7883.369330453578;7720.7683769487;7792.844143117162;7817.648205830695;7823.374130069581;7842.098158711707;35927.82036089829;36480;36540.81729591361;36621.450678239846;36630.63369366299;3026.9243268918235;3049.7560195184333;3176.142441540794;3436.896893093211;3566.4293713006055;26978.865105674347;27021.324466888287;27414.725852741416;27909.150109113147;28044.298892527648;3476.8609255629744;3487.3025394920865;3503.1767534629344;3581.0510214793103;3614.7831130132013;216735;217338;217595.99999999843;217772;219706;32106;51185.440727963454;51809.740951295;51846.74076629593;51860;31451.213719656735;31482.527762083588;31528.842355788533;31645.683543164734;31864.522032169534;12641.494340226473;12914.354282285849;12923.935380323039;12926;12934.676633084247;10397.63608273722;10445.373277603216;10463.110635595907;10474.895251047545;10502.05481506668;7950.6422211000645;8076.919230807616;8162.102168761431;8163.7142700005215;8201.671933122609;3148.842557872097;3214.6785321468133;3250;3268.542404063433;3289.5394644749754;902.9413088149249;902.9819403612022;928.6424726480353;940.5955439161227;1015.7562185075676;27398.354900090428;27506.449871002467;28049.859750701115;28054.43891122166;28563.57154642682;963.7735132243918;968.3173362779223;1022.9181665466745;1104.9005589496983;1115.3976852499723;13016.739665206644;13346.666333341744;13514.526991555249;13541.39063742134;13597.86402135966;308064;315835;318563;318794;320424;46670;47375.28937065947;47407.76296118566;47821.76089119532;47847.76076119667;1207.2032458577296;1250.4498020870788;1260.9936950315189;1267.6577324122436;1282.8204051432806;24328;25488.235352939442;25997.22008339753;26345.736542634328;26349;39141.41287880741;39619.80190099031;39678.801605991786;39880.800595996836;40053.39919901145;293530;296622;298475;299036;300184;24623.50752984966;24714;25217.87391063033;25253.747462525873;25401.87299063493;40149.799251003555;40337.39493907535;40459.3931091028;40469.797651011555;41113;35053.29893402067;35147.648523514436;35167.296654067286;35382.8230858844;35449.82275088711;34321.82839085789;34464.310713786086;34522.82738586291;34594.13514662053;35050.64949350474;34680.65319346875;35138;35380.11549711175;35815.28369432649;37306.25387492181;28216.15351539457;30286;30545.54181687321;30768.230794230323;30788.38423231478;24259.272221833373;24318.51362972766;24446.14438494644;24827.751722482542;24831.503369932863 17:29:15 INFO - PROCESS | 20271 | |2;jquery.html;367.98344074516643;372.74653235799656;378.4625831319526;381.1367253171567;395.08537735143125;15526.767098493518;15893.761593576091;16522.421715239983;16552.917235413806;16681.582960425996;14300.71398572028;14987;14990.700185996273;14991.400343986228;15000.174990375524;4449.710768800026;4854.708717476945;4854.805807767685;4855.271709243606;4857.538533839297;3423.0928803866996;4742.2886567014875;5140.408852981899;5358.008768377863;5383.111786555213;5381.058314794915;5402.513773760361;5402.567794576444;5418.160185171285;5423.349198096214;5273.630845840793;5980.88038239235;6086.665233412161;6090.390960903918;6104.236970378703;5218.791248350061;5390.056740070472;5418.566514678816;5440.156775699773;5453.4273901240595;12794.296313702742;15114.54656360311;20058.498537536532;20172.899135504376;20567.280145194847;1769.5310742653207;1884.1144662008971;1886.4057821786093;1930.1121484117323;2037.1138554728593;8878.422902511316;9598.280128990353;9600.90399096007;12765.170263932907;13441.126326788824;1823.5441139715072;1841.438361299803;1860.1443336065427;1868.4768264885854;1883.8022007689133;65335.67332163356;66491.66754166246;67361;67797;68849.65575172142;9825.312228143961;9916.702498925044;10002.49987500622;10012.949935250277;10274.33216840903;13977.860221397656;13985.65035874091;14043.438262469386;14055.859441405455;14102.576922692335;6881.8967715484305;7032.472564557678;7141.357277845019;7170.139583249939;7228.337482379082;6515.087887695727;6520.673966301666;6566.113574667359;6670.266270710218;6677.131972843499;4309.159713855768;4402.4056752338665;4426.822927082881;4431.667624928144;4441.644668426518;1780.910954452272;1821.8360347568782;1859.8884066956025;1877.9295801393348;1888.745019422388;396.6885994494308;402.20765092767203;423.5975822968131;834.9373796965252;892.7991850960448;10154.949225253975;10264.846027309597;10375.858655547883;10459.372437653765;10494.422806745702;418.38915183831944;436.75541696649975;814.3322475570094;894.9776255593532;923.5290002098978;8612.784680382916;8698;8760.211580957744;8812.295016398673;9107.134822191882;389638;406046;416808;421104;421747;75246.62376688082;75543.62228188824;76543.61728191323;77072;78136.60931695419;968.8062387522524;986.7187851462443;1000.5092412305758;1019.3985548526405;1021.2238698589126;14071.718565628425;14431.134131951696;15283.006604570668;15325.233738313264;15415;30920.845395772878;31468.370632587677;32457.350852982338;32557.18607034843;33082.83458582692;39236.41145382765;39967.800161000174;40033.399499006955;40194.59805401909;40307;7728.4590078693955;7833.1775163607;7865.567393793396;8077.717279895175;8092.433529652868;8754.25588824957;10290.485475726035;10323.174146068446;11693.707657308636;11836.230645008047;9797.363171393836;10250.282480226313;10291.588336466757;10322;10509.9474502627;10171.593136274467;10176.18590512772;10404;10547.78904421892;10801.837972430263;10099.79800403973;10267.646898438827;10736.30214036085;10856.674299771019;10893.56425742993;7404.925950740424;7813.14055453911;7912.248336408032;7948.244916732901;8211.753647390588;9708.368956017835;10790.369091689176;10792.784144317227;10951.178661600572;11110.555577777122 17:29:15 INFO - PROCESS | 20271 | |3;mootools.html;1464.1507925403266;1476.6234610174404;1574.4253347528156;1769.8849574777646;1801.837834594887;6725.798226053214;7361.521501102425;7452.7391541296065;7652.885206721897;7690.692372305115;7408.59252741099;7495.962520187391;7513.098428188625;7573.318401343878;7583.393328533718;2174.8803815790125;2190.868547887124;2198.505336299336;2204.4488877780555;2210.35899589119;2155.91376344946;2184.224600266898;2261.389424855288;2266.9319920402413;2269.1604106480545;2199.49411635324;2227.40973641985;2227.4208705736546;2252.650839119939;2281.543691261746;2120.703101565782;2134.583756167548;2150.311900191939;2152.257471172443;2158.298552970275;2211.590855691686;2260.3219034289646;2274.3972847195505;2279.566882292359;2283.897224624896;7620.390368770485;7629.198934111894;7692.0384951881015;7694.422918281151;7747.418943579254;4386.912261754779;4553.339765733983;4555.521670224612;4559;4579.290210017452;2795.343094372821;2882.0489238551227;2885.2642576143157;2936.07513633207;2952.9557056644167;953.0945601678433;957.2389949989774;975.3465178330536;977.3988996767008;982.2289502740315;9880;9930.602775888956;9954.303198776088;10019.04819042197;10038.548265328005;4067.613576710208;4081.8775436736946;4199.769012704331;4289.82840686369;4298.677599180074;8556;8612.397132200686;8624.568771561397;8637.784055398539;8646.43798153118;4556.476005259371;4560.156371071296;4587.197240482902;4590.609798167193;4604.677672562955;3667.5598928128798;4081.2653722330265;4181.268278051329;4189.706720529594;4210.6841986850495;3582.194006348551;3621.348157331706;3695.981520092382;3714.294284086015;3739.8691045813266;1240.925544467335;1251.3117785218276;1256.0579565326007;1264.7217612125319;1268.239056566053;919.7562645898843;940.1350757303297;942.8020115775627;976.5995941663883;1254.1659796235401;7022.508424410345;7036.718531258794;7047.859042819115;7063.04648872406;7229.385502232369;430.5952404739535;448.20220008385127;457.9152856721517;460.07754452322877;460.1854717150625;5404.054290499147;5422.240886275925;5437.673739575638;5459.727013649302;5466.480684334982;8985.146411090936;9369.156775890202;9431.952840235756;9443.90556094444;9515.381500202464;9142.954285228532;9273.953630231807;9303.953480232556;9337.393069450463;9411.294152938557;7196.244394338623;7251.528650637797;7256.854862902818;7331.670074846645;7344.155422126524;6907.6891539881835;7022.332878376546;7077.044598979072;7091.60996145217;7093.964530177316;8585.785355365915;8671.696490622799;8885.955570222108;8914.910850891409;8921.776955576162;8549.14508549165;8554.871676924726;8745.125487451458;8817.426867253607;8847.336449766164;6027.849303767441;6163.322034576283;6339.270983836734;6539.11721917554;6698.698558564974;6889.896651550331;6906.482013849082;6943.826404339729;6963.2340442552295;6969.616671083139;6187.443130118311;6416.358364163546;6427.357264273535;6485.3514648534765;6531.869362612626;6346.90479642815;6476.287608362982;6508.414242718178;6560.442362399059;6701.530892837454;6828.897566536407;6876.381125698711;6895.724171033103;6906.171259448898;6908.620025898624;6145.262568491809;6196.225471816023;6258.155149055002;6302.905456418066;6312.116303717391;6227.875442491216;6249.6562689052535;6265.028920517327;6281.623102613858;6298.968505157445 17:29:15 INFO - PROCESS | 20271 | |4;prototype.html;307.68001278670187;312.5639732573061;315.03127881763584;318.0331791354283;318.21559854957525;5286.947130528693;5398.81104161355;5399.272232885473;5431.728413579315;5432.619716619838;5292.444293349201;5337.946620533793;5340.25236466895;5343;5344.412114667393;3925.15609144034;4044.8786536403954;4157.127003329305;4161.981439002082;4189.706720529556;4175.185838761443;4190.685698572604;4200.411942328076;4204.474440694913;4210.157968406331;4186.079062606222;4187.016051227959;4187.979060104695;4192.149338449853;4206.47419072616;4097.282975479279;4177.624013838738;4183.205191013728;4188.6439652629415;4189.308764053927;3671.724620653435;3673.6326367363317;3676.871309504181;3677.2093999789904;3682.4660424238336;5128.743562821844;5132.153194722866;5142.820001299974;5152.278680984665;5154.664946778447;4707.411573553306;4792.9281060784115;4805.087033463666;4805.975970120162;4817.458413307743;5573.27547418833;5594.356648985378;5619.297587801525;5624.29696287964;5651.8304450866535;4000.239954408653;4000.4599379084034;4020.5376381716183;4022;4034.132661477767;5742.856428589277;5920.437558431985;5956.880862382728;5968.104784282349;5986.700664966777;4121.381792731055;4148.979255103705;4149.460570125864;4150.107726838744;4158.168366326747;4189.308764053897;4198.223328684203;4202.495700515897;4207.705460617727;4216.810243539048;4628.722276663411;4807.831725889647;4809.182438985381;4809.807607695653;4812.013537224861;5576.804811831647;5656.377798442168;5658.321001479767;5672.347680016851;5693.637140586693;1436.4182506085053;1444.4222311075655;1458.3947661720267;1461.4811741831709;1464.9818376228418;930.6277489004317;972.2027937091658;991.5686676295834;1008.1732978957185;1012.8025035118228;4854.781534830941;4998.775055122455;5022.472640372781;5039.82360617384;5040.470750571138;5894;5900.527957763368;5920.542974665465;5926.436988486087;5929.288485381696;4866.294387313819;4999;5026.874328141826;5052.747362631853;5081.822136225214;3126.89055883043;3159.9572141193353;3165.1454107390878;3165.9710594057024;3171.2864605463587;5472.534834539029;5509.3664228613425;5512.255845460892;5523.696196709219;5532.948739739437;5740.856478587985;6001.3098493672915;6080.422359875804;6093.11649810775;6099.603525770811;5478.315210598676;5482.890342193134;5510.410107249586;5523.861903452365;5538.944610553924;5772.614572502654;5864.624826945094;5897.439743224387;5897.64614123154;5898.557608179318;5772.018756811436;5789.942100579109;5796.1305804129715;5801.650331615702;5821.563382746395;5487.314085739283;5527.088030474926;5528.7235638218735;5530.479118242515;5555.0834112371;3979.0649197439157;4027.677785777072;4032;4046.5548789632526;4051.9797401013984;5875.794347197828;5878.676672782867;5904.844731672994;5910.1725758392995;5918.2898052234;5714.857128571819;5728.3412407572;5728.914066288926;5744.569157313134;5761.769529218785;5429.375621803543;5743.167240749985;5760.423957604206;5762.164486149569;5767.942320576741;5262.315898933114;5629.437056294338;5644.971775141098;5666.17840413146;5667.376588575171;5544.500994910478;5666.575006874418;5706.172604972173;5739.368669446274;5757.5681823864215;5560.443955604407;5590.468905453975;5617.943820561905;5618.88762224745;5626.127950167567 17:29:15 INFO - PROCESS | 20271 | |5;yui.html;676.7698982346002;706.77383237364;722.4798145335359;745.3738859358139;751.3388218367837;10150.74623134422;10693.465326733662;10883.673489795308;11509.136814738886;12156.939215303933;13482.460701571925;13508.93245533771;13598.660033499144;13604.387802548885;13608.455661773518;641.0576452614672;798.4530596541359;821.322409012564;824.4105464592815;825.2531459029587;810.3152835853724;812.0215140755375;812.743985644523;813.9145389734082;816.3346872299057;846.3821410370433;848.2704873808519;849.1550906847664;850.306999795168;851.29342645604;843.7890527368158;844.1558441558442;845.6406027438345;847.9830403391928;848.2747251100282;621.2638023941644;621.710904429438;622.7260005597568;622.9159063526412;623.2147494157394;11387.772244555063;11431.085513158927;11468.71328216793;11473.311601303865;11491.827622585668;12694;12954.740905181938;13041.934790326082;13086.86913130866;13203.603891883258;10286.434246116462;10327.483625818679;10428.21788365868;10525.21060920434;10653.893461065367;3386.204242003127;3406.5741782277214;3444.3627928832993;3448.103493091789;3456.602490713575;48604.27093593599;48806.26790598144;49957.25064124041;50020.74989625029;50174;10248.333858299187;10336.793264134676;10339.121174700234;10366.896331036744;10457.84313235302;17495.825041749675;18809.717854232196;18833.43499694984;18874.62250754977;18918.527036823914;6579.342065793382;6585.275619681831;6719.0593316935665;6734.292899245606;6804.285550017276;3553.893383198508;3643.198496330803;3663.9816800915823;3689.6494832990825;3748.0817199785683;2758.5724212747054;2863.7565806906227;2867.641544806899;2876;3175.968240317567;556.3574071946908;567.3617180671745;570.0736303506801;572.8796952639992;578.8466056495032;620.5687047502033;626.3736263736264;640.484410049905;641.685574068703;646.1309538670481;7459.254074592606;7755.379569634416;8004.719834805754;8208.343332533383;8244.917550824535;583.9591228614041;614.883172197281;616.315889362807;624.4411251929498;632.4023797511308;3837.213371258885;3879.612038796154;3989.6409323161056;4279.850205242864;4312.913741725148;51509.48490515122;52541.110238937224;52581;52717.209241861405;54016.72991635095;43481.56518434839;45730.771346143054;46615.53384466112;46788;48376;43562.56437435649;45053.269406712476;45229.77385113119;45424.77287613607;45538.77230613826;8172.713955011546;8222.17778222173;8237.711680091168;8250.587470626564;8356.832863342821;28495.715042849308;28718.856405717837;28858.134255972356;28879.85560072186;29029.419411611227;37403.2519349606;38087.61912380841;39975.60024399835;40345.1930961385;40593;10602.363858168535;10626.36241825493;10779.083777878968;10794.082502987334;10811.459427028774;11687.76624467489;11842.171048026556;11982.221155624857;12062.336571488653;12296.692582685504;11795.351255680676;11974.161808673309;12181.33002684861;12362.690932726753;12376.81434778497;10536.420496872746;10852.348859068481;10885.673429797118;10945.616903408662;11912.166148369532;10924.749554238651;11045.668629941114;11140.888591113986;11443.713907152387;11653.941730291293;9418.95290523543;9570.521473926416;9588.280878933969;9836.950815245878;9889.307748457539;9405.717828465156;9651.557353769223;9698.85451718239;9744.17174540172;9748.61347646276 17:29:15 INFO - PROCESS | 20271 | __end_tp_report 17:29:15 INFO - PROCESS | 20271 | __start_cc_report 17:29:15 INFO - PROCESS | 20271 | _x_x_mozilla_cycle_collect,373 17:29:15 INFO - PROCESS | 20271 | __end_cc_report 17:29:15 INFO - PROCESS | 20271 | __startTimestamp1460161755721__endTimestamp 17:29:15 INFO - PROCESS | 20271 | 17:29:15 INFO - PROCESS | 20271 | ------- Summary: start ------- 17:29:15 INFO - PROCESS | 20271 | Number of tests: 6 17:29:15 INFO - PROCESS | 20271 | 17:29:15 INFO - PROCESS | 20271 | [#0] dojo.html Cycles:165 Average:4648.76 Median:4764.24 stddev:470.56 (9.9%) stddev-sans-first:444.60 17:29:15 INFO - PROCESS | 20271 | Values: 2631.5 2672.8 2704.3 2710.0 2715.5 4618.2 4632.1 4662.3 4671.6 4703.7 4618.9 4697.3 4764.2 4777.3 4781.7 4296.9 4326.5 4371.1 4386.1 4418.6 4347.3 4387.2 4421.5 4433.0 4436.3 4236.7 4282.4 4300.0 4337.8 4355.8 4347.2 4358.5 4365.5 4366.0 4376.3 4339.4 4339.5 4344.4 4346.2 4399.6 4510.6 4581.0 4634.9 4651.7 4651.9 4994.7 5016.5 5018.0 5036.6 5082.9 5057.7 5060.8 5063.6 5066.3 5136.2 4580.1 4663.9 4724.1 4739.6 4748.5 5127.4 5146.3 5160.5 5164.9 5187.0 4916.9 4932.3 4940.8 4959.4 4959.6 4890.9 4978.3 4994.8 5066.5 5074.1 4851.3 4932.6 4935.1 4940.5 4942.2 4900.0 4903.3 4905.6 4974.0 5039.3 4229.9 4259.4 4261.2 4270.9 4305.7 3622.0 3644.6 3721.1 3749.8 3760.3 4423.8 4433.4 4435.9 4460.1 4479.4 4997.1 5057.6 5077.2 5085.4 5149.5 4327.2 4392.7 4421.9 4464.3 4475.2 4527.2 4535.2 4536.4 4540.6 4585.5 4707.0 4735.3 4739.1 4749.2 4802.2 4891.1 5023.5 5068.8 5099.6 5143.9 4683.6 4734.5 4736.0 4739.0 4772.9 4843.1 4951.8 4953.8 4964.2 5021.1 5007.7 5015.2 5023.7 5073.7 5077.2 4844.4 4870.8 4871.6 4877.3 4924.5 4772.7 4810.2 4819.9 4832.9 4922.2 4741.1 4809.1 4810.2 4823.9 4834.5 4884.4 4901.4 4906.7 4916.9 4959.1 4672.5 4809.1 4822.0 4827.8 4868.0 17:29:15 INFO - PROCESS | 20271 | 17:29:15 INFO - PROCESS | 20271 | [#1] ext.html Cycles:180 Average:41944.02 Median:34493.57 stddev:73676.60 (213.6%) stddev-sans-first:73817.76 17:29:15 INFO - PROCESS | 20271 | Values: 557.6 590.5 592.2 607.3 624.0 25975.4 32513.8 33514.3 33554.8 33676.5 37732.8 38807.2 38923.0 39366.2 39382.8 7701.8 7880.3 7892.1 7899.8 7900.0 7684.6 7805.8 7812.3 7831.3 7841.6 7853.8 7895.1 7915.1 7922.4 7931.3 7816.6 7820.8 7829.1 7864.0 7883.4 7720.8 7792.8 7817.6 7823.4 7842.1 35927.8 36480.0 36540.8 36621.5 36630.6 3026.9 3049.8 3176.1 3436.9 3566.4 26978.9 27021.3 27414.7 27909.2 28044.3 3476.9 3487.3 3503.2 3581.1 3614.8 216735.0 217338.0 217596.0 217772.0 219706.0 32106.0 51185.4 51809.7 51846.7 51860.0 31451.2 31482.5 31528.8 31645.7 31864.5 12641.5 12914.4 12923.9 12926.0 12934.7 10397.6 10445.4 10463.1 10474.9 10502.1 7950.6 8076.9 8162.1 8163.7 8201.7 3148.8 3214.7 3250.0 3268.5 3289.5 902.9 903.0 928.6 940.6 1015.8 27398.4 27506.4 28049.9 28054.4 28563.6 963.8 968.3 1022.9 1104.9 1115.4 13016.7 13346.7 13514.5 13541.4 13597.9 308064.0 315835.0 318563.0 318794.0 320424.0 46670.0 47375.3 47407.8 47821.8 47847.8 1207.2 1250.4 1261.0 1267.7 1282.8 24328.0 25488.2 25997.2 26345.7 26349.0 39141.4 39619.8 39678.8 39880.8 40053.4 293530.0 296622.0 298475.0 299036.0 300184.0 24623.5 24714.0 25217.9 25253.7 25401.9 40149.8 40337.4 40459.4 40469.8 41113.0 35053.3 35147.6 35167.3 35382.8 35449.8 34321.8 34464.3 34522.8 34594.1 35050.6 34680.7 35138.0 35380.1 35815.3 37306.3 28216.2 30286.0 30545.5 30768.2 30788.4 24259.3 24318.5 24446.1 24827.8 24831.5 17:29:15 INFO - PROCESS | 20271 | 17:29:15 INFO - PROCESS | 20271 | [#2] jquery.html Cycles:180 Average:24040.42 Median:40114.00 stddev:67660.33 (168.7%) stddev-sans-first:67826.79 17:29:15 INFO - PROCESS | 20271 | Values: 368.0 372.7 378.5 381.1 395.1 15526.8 15893.8 16522.4 16552.9 16681.6 14300.7 14987.0 14990.7 14991.4 15000.2 4449.7 4854.7 4854.8 4855.3 4857.5 3423.1 4742.3 5140.4 5358.0 5383.1 5381.1 5402.5 5402.6 5418.2 5423.3 5273.6 5980.9 6086.7 6090.4 6104.2 5218.8 5390.1 5418.6 5440.2 5453.4 12794.3 15114.5 20058.5 20172.9 20567.3 1769.5 1884.1 1886.4 1930.1 2037.1 8878.4 9598.3 9600.9 12765.2 13441.1 1823.5 1841.4 1860.1 1868.5 1883.8 65335.7 66491.7 67361.0 67797.0 68849.7 9825.3 9916.7 10002.5 10012.9 10274.3 13977.9 13985.7 14043.4 14055.9 14102.6 6881.9 7032.5 7141.4 7170.1 7228.3 6515.1 6520.7 6566.1 6670.3 6677.1 4309.2 4402.4 4426.8 4431.7 4441.6 1780.9 1821.8 1859.9 1877.9 1888.7 396.7 402.2 423.6 834.9 892.8 10154.9 10264.8 10375.9 10459.4 10494.4 418.4 436.8 814.3 895.0 923.5 8612.8 8698.0 8760.2 8812.3 9107.1 389638.0 406046.0 416808.0 421104.0 421747.0 75246.6 75543.6 76543.6 77072.0 78136.6 968.8 986.7 1000.5 1019.4 1021.2 14071.7 14431.1 15283.0 15325.2 15415.0 30920.8 31468.4 32457.4 32557.2 33082.8 39236.4 39967.8 40033.4 40194.6 40307.0 7728.5 7833.2 7865.6 8077.7 8092.4 8754.3 10290.5 10323.2 11693.7 11836.2 9797.4 10250.3 10291.6 10322.0 10509.9 10171.6 10176.2 10404.0 10547.8 10801.8 10099.8 10267.6 10736.3 10856.7 10893.6 7404.9 7813.1 7912.2 7948.2 8211.8 9708.4 10790.4 10792.8 10951.2 11110.6 17:29:15 INFO - PROCESS | 20271 | 17:29:15 INFO - PROCESS | 20271 | [#3] mootools.html Cycles:180 Average:5278.29 Median:6325.69 stddev:2775.12 (43.9%) stddev-sans-first:2768.10 17:29:15 INFO - PROCESS | 20271 | Values: 1464.2 1476.6 1574.4 1769.9 1801.8 6725.8 7361.5 7452.7 7652.9 7690.7 7408.6 7496.0 7513.1 7573.3 7583.4 2174.9 2190.9 2198.5 2204.4 2210.4 2155.9 2184.2 2261.4 2266.9 2269.2 2199.5 2227.4 2227.4 2252.7 2281.5 2120.7 2134.6 2150.3 2152.3 2158.3 2211.6 2260.3 2274.4 2279.6 2283.9 7620.4 7629.2 7692.0 7694.4 7747.4 4386.9 4553.3 4555.5 4559.0 4579.3 2795.3 2882.0 2885.3 2936.1 2953.0 953.1 957.2 975.3 977.4 982.2 9880.0 9930.6 9954.3 10019.0 10038.5 4067.6 4081.9 4199.8 4289.8 4298.7 8556.0 8612.4 8624.6 8637.8 8646.4 4556.5 4560.2 4587.2 4590.6 4604.7 3667.6 4081.3 4181.3 4189.7 4210.7 3582.2 3621.3 3696.0 3714.3 3739.9 1240.9 1251.3 1256.1 1264.7 1268.2 919.8 940.1 942.8 976.6 1254.2 7022.5 7036.7 7047.9 7063.0 7229.4 430.6 448.2 457.9 460.1 460.2 5404.1 5422.2 5437.7 5459.7 5466.5 8985.1 9369.2 9432.0 9443.9 9515.4 9143.0 9274.0 9304.0 9337.4 9411.3 7196.2 7251.5 7256.9 7331.7 7344.2 6907.7 7022.3 7077.0 7091.6 7094.0 8585.8 8671.7 8886.0 8914.9 8921.8 8549.1 8554.9 8745.1 8817.4 8847.3 6027.8 6163.3 6339.3 6539.1 6698.7 6889.9 6906.5 6943.8 6963.2 6969.6 6187.4 6416.4 6427.4 6485.4 6531.9 6346.9 6476.3 6508.4 6560.4 6701.5 6828.9 6876.4 6895.7 6906.2 6908.6 6145.3 6196.2 6258.2 6302.9 6312.1 6227.9 6249.7 6265.0 6281.6 6299.0 17:29:15 INFO - PROCESS | 20271 | 17:29:15 INFO - PROCESS | 20271 | [#4] prototype.html Cycles:180 Average:4709.28 Median:5339.10 stddev:1378.23 (25.8%) stddev-sans-first:1341.92 17:29:15 INFO - PROCESS | 20271 | Values: 307.7 312.6 315.0 318.0 318.2 5286.9 5398.8 5399.3 5431.7 5432.6 5292.4 5337.9 5340.3 5343.0 5344.4 3925.2 4044.9 4157.1 4162.0 4189.7 4175.2 4190.7 4200.4 4204.5 4210.2 4186.1 4187.0 4188.0 4192.1 4206.5 4097.3 4177.6 4183.2 4188.6 4189.3 3671.7 3673.6 3676.9 3677.2 3682.5 5128.7 5132.2 5142.8 5152.3 5154.7 4707.4 4792.9 4805.1 4806.0 4817.5 5573.3 5594.4 5619.3 5624.3 5651.8 4000.2 4000.5 4020.5 4022.0 4034.1 5742.9 5920.4 5956.9 5968.1 5986.7 4121.4 4149.0 4149.5 4150.1 4158.2 4189.3 4198.2 4202.5 4207.7 4216.8 4628.7 4807.8 4809.2 4809.8 4812.0 5576.8 5656.4 5658.3 5672.3 5693.6 1436.4 1444.4 1458.4 1461.5 1465.0 930.6 972.2 991.6 1008.2 1012.8 4854.8 4998.8 5022.5 5039.8 5040.5 5894.0 5900.5 5920.5 5926.4 5929.3 4866.3 4999.0 5026.9 5052.7 5081.8 3126.9 3160.0 3165.1 3166.0 3171.3 5472.5 5509.4 5512.3 5523.7 5532.9 5740.9 6001.3 6080.4 6093.1 6099.6 5478.3 5482.9 5510.4 5523.9 5538.9 5772.6 5864.6 5897.4 5897.6 5898.6 5772.0 5789.9 5796.1 5801.7 5821.6 5487.3 5527.1 5528.7 5530.5 5555.1 3979.1 4027.7 4032.0 4046.6 4052.0 5875.8 5878.7 5904.8 5910.2 5918.3 5714.9 5728.3 5728.9 5744.6 5761.8 5429.4 5743.2 5760.4 5762.2 5767.9 5262.3 5629.4 5645.0 5666.2 5667.4 5544.5 5666.6 5706.2 5739.4 5757.6 5560.4 5590.5 5617.9 5618.9 5626.1 17:29:15 INFO - PROCESS | 20271 | 17:29:15 INFO - PROCESS | 20271 | [#5] yui.html Cycles:180 Average:13046.63 Median:43522.06 stddev:14829.08 (34.1%) stddev-sans-first:14841.59 17:29:15 INFO - PROCESS | 20271 | Values: 676.8 706.8 722.5 745.4 751.3 10150.7 10693.5 10883.7 11509.1 12156.9 13482.5 13508.9 13598.7 13604.4 13608.5 641.1 798.5 821.3 824.4 825.3 810.3 812.0 812.7 813.9 816.3 846.4 848.3 849.2 850.3 851.3 843.8 844.2 845.6 848.0 848.3 621.3 621.7 622.7 622.9 623.2 11387.8 11431.1 11468.7 11473.3 11491.8 12694.0 12954.7 13041.9 13086.9 13203.6 10286.4 10327.5 10428.2 10525.2 10653.9 3386.2 3406.6 3444.4 3448.1 3456.6 48604.3 48806.3 49957.3 50020.7 50174.0 10248.3 10336.8 10339.1 10366.9 10457.8 17495.8 18809.7 18833.4 18874.6 18918.5 6579.3 6585.3 6719.1 6734.3 6804.3 3553.9 3643.2 3664.0 3689.6 3748.1 2758.6 2863.8 2867.6 2876.0 3176.0 556.4 567.4 570.1 572.9 578.8 620.6 626.4 640.5 641.7 646.1 7459.3 7755.4 8004.7 8208.3 8244.9 584.0 614.9 616.3 624.4 632.4 3837.2 3879.6 3989.6 4279.9 4312.9 51509.5 52541.1 52581.0 52717.2 54016.7 43481.6 45730.8 46615.5 46788.0 48376.0 43562.6 45053.3 45229.8 45424.8 45538.8 8172.7 8222.2 8237.7 8250.6 8356.8 28495.7 28718.9 28858.1 28879.9 29029.4 37403.3 38087.6 39975.6 40345.2 40593.0 10602.4 10626.4 10779.1 10794.1 10811.5 11687.8 11842.2 11982.2 12062.3 12296.7 11795.4 11974.2 12181.3 12362.7 12376.8 10536.4 10852.3 10885.7 10945.6 11912.2 10924.7 11045.7 11140.9 11443.7 11653.9 9419.0 9570.5 9588.3 9837.0 9889.3 9405.7 9651.6 9698.9 9744.2 9748.6 17:29:15 INFO - PROCESS | 20271 | -------- Summary: end -------- 17:29:15 INFO - PROCESS | 20271 | 17:29:16 INFO - TEST-INFO | 20271: exit 0 17:29:16 INFO - TEST-OK | dromaeo_css | took 1114478ms 17:29:16 INFO - TEST-START | kraken 17:29:16 INFO - operating with platform_type : linux_ 17:29:16 INFO - Initialising browser for kraken test... 17:29:16 INFO - TEST-INFO | started process 20510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Bm_ft/profile http://localhost:35384/getInfo.html) 17:29:20 INFO - PROCESS | 20510 | 17:29:20 INFO - PROCESS | 20510 | (process:20580): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:29:20 INFO - PROCESS | 20510 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:29:20 INFO - PROCESS | 20510 | __metrics Screen width/height:1600/1200 17:29:20 INFO - PROCESS | 20510 | colorDepth:24 17:29:20 INFO - PROCESS | 20510 | Browser inner width/height: 1024/697 17:29:20 INFO - PROCESS | 20510 | __metrics 17:29:21 ERROR - PROCESS | 20510 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 17:29:22 INFO - TEST-INFO | 20510: exit 0 17:29:22 INFO - Browser initialized. 17:29:22 INFO - Running cycle 1/1 for kraken test... 17:29:22 INFO - TEST-INFO | started process 20631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Bm_ft/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:24 INFO - PROCESS | 20631 | 17:29:24 INFO - PROCESS | 20631 | (process:20692): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:29:34 INFO - PROCESS | 20631 | RSS: Main: 164913152 17:29:34 INFO - PROCESS | 20631 | 17:29:36 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35384/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:37 INFO - PROCESS | 20631 | RSS: Main: 169062400 17:29:37 INFO - PROCESS | 20631 | 17:29:40 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35384/tests/kraken/driver.html?testName=audio-dft) 17:29:41 INFO - PROCESS | 20631 | RSS: Main: 172449792 17:29:41 INFO - PROCESS | 20631 | 17:29:43 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35384/tests/kraken/driver.html?testName=audio-fft) 17:29:44 INFO - PROCESS | 20631 | RSS: Main: 162635776 17:29:44 INFO - PROCESS | 20631 | 17:29:46 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35384/tests/kraken/driver.html?testName=audio-oscillator) 17:29:47 INFO - PROCESS | 20631 | RSS: Main: 163053568 17:29:47 INFO - PROCESS | 20631 | 17:29:49 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35384/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:50 INFO - PROCESS | 20631 | RSS: Main: 164601856 17:29:50 INFO - PROCESS | 20631 | 17:29:53 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35384/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:53 INFO - PROCESS | 20631 | RSS: Main: 164683776 17:29:53 INFO - PROCESS | 20631 | 17:29:57 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35384/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:58 INFO - PROCESS | 20631 | RSS: Main: 165167104 17:29:58 INFO - PROCESS | 20631 | 17:30:00 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35384/tests/kraken/driver.html?testName=json-parse-financial) 17:30:01 INFO - PROCESS | 20631 | RSS: Main: 165347328 17:30:01 INFO - PROCESS | 20631 | 17:30:03 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35384/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:03 INFO - PROCESS | 20631 | RSS: Main: 165535744 17:30:03 INFO - PROCESS | 20631 | 17:30:05 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:06 INFO - PROCESS | 20631 | RSS: Main: 165195776 17:30:06 INFO - PROCESS | 20631 | 17:30:08 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:09 INFO - PROCESS | 20631 | RSS: Main: 165605376 17:30:09 INFO - PROCESS | 20631 | 17:30:12 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:12 INFO - PROCESS | 20631 | RSS: Main: 165765120 17:30:12 INFO - PROCESS | 20631 | 17:30:15 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:16 INFO - PROCESS | 20631 | RSS: Main: 166543360 17:30:16 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35384/tests/kraken/driver.html?testName=ai-astar) 17:30:18 INFO - PROCESS | 20631 | RSS: Main: 167473152 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | __start_tp_report 17:30:18 INFO - PROCESS | 20631 | _x_x_mozilla_page_load 17:30:18 INFO - PROCESS | 20631 | _x_x_mozilla_page_load_details 17:30:18 INFO - PROCESS | 20631 | |i|pagename|runs| 17:30:18 INFO - PROCESS | 20631 | |0;ai-astar;113;111;115;113;115;128;116;114;114;114 17:30:18 INFO - PROCESS | 20631 | |1;audio-beat-detection;165;133;156;176;135;168;162;136;191;136 17:30:18 INFO - PROCESS | 20631 | |2;audio-dft;162;165;164;163;164;174;165;164;166;162 17:30:18 INFO - PROCESS | 20631 | |3;audio-fft;73;74;75;77;72;75;73;152;74;76 17:30:18 INFO - PROCESS | 20631 | |4;audio-oscillator;95;94;133;94;96;94;138;94;96;139 17:30:18 INFO - PROCESS | 20631 | |5;imaging-gaussian-blur;117;118;117;118;118;118;119;118;118;119 17:30:18 INFO - PROCESS | 20631 | |6;imaging-darkroom;147;148;146;148;148;148;147;147;147;148 17:30:18 INFO - PROCESS | 20631 | |7;imaging-desaturate;97;97;96;96;97;96;96;96;96;96 17:30:18 INFO - PROCESS | 20631 | |8;json-parse-financial;66;67;66;65;72;65;65;65;66;65 17:30:18 INFO - PROCESS | 20631 | |9;json-stringify-tinderbox;64;64;64;64;66;65;65;66;65;65 17:30:18 INFO - PROCESS | 20631 | |10;stanford-crypto-aes;87;88;86;86;85;88;92;85;87;88 17:30:18 INFO - PROCESS | 20631 | |11;stanford-crypto-ccm;139;144;138;142;155;141;151;145;159;140 17:30:18 INFO - PROCESS | 20631 | |12;stanford-crypto-pbkdf2;174;173;174;175;174;173;175;177;173;174 17:30:18 INFO - PROCESS | 20631 | |13;stanford-crypto-sha256-iterative;76;75;73;73;73;73;73;74;72;74 17:30:18 INFO - PROCESS | 20631 | __end_tp_report 17:30:18 INFO - PROCESS | 20631 | __start_cc_report 17:30:18 INFO - PROCESS | 20631 | _x_x_mozilla_cycle_collect,936 17:30:18 INFO - PROCESS | 20631 | __end_cc_report 17:30:18 INFO - PROCESS | 20631 | __startTimestamp1460161818261__endTimestamp 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | ------- Summary: start ------- 17:30:18 INFO - PROCESS | 20631 | Number of tests: 14 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#0] ai-astar Cycles:10 Average:115.30 Median:114.50 stddev:4.67 (4.1%) stddev-sans-first:4.88 17:30:18 INFO - PROCESS | 20631 | Values: 113.0 111.0 115.0 113.0 115.0 128.0 116.0 114.0 114.0 114.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:163.50 stddev:20.15 (12.3%) stddev-sans-first:21.10 17:30:18 INFO - PROCESS | 20631 | Values: 165.0 133.0 156.0 176.0 135.0 168.0 162.0 136.0 191.0 136.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:3.45 (2.1%) stddev-sans-first:3.49 17:30:18 INFO - PROCESS | 20631 | Values: 162.0 165.0 164.0 163.0 164.0 174.0 165.0 164.0 166.0 162.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#3] audio-fft Cycles:10 Average:82.10 Median:74.50 stddev:24.61 (33.0%) stddev-sans-first:25.88 17:30:18 INFO - PROCESS | 20631 | Values: 73.0 74.0 75.0 77.0 72.0 75.0 73.0 152.0 74.0 76.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:20.34 (21.6%) stddev-sans-first:21.08 17:30:18 INFO - PROCESS | 20631 | Values: 95.0 94.0 133.0 94.0 96.0 94.0 138.0 94.0 96.0 139.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 17:30:18 INFO - PROCESS | 20631 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 119.0 118.0 118.0 119.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:30:18 INFO - PROCESS | 20631 | Values: 147.0 148.0 146.0 148.0 148.0 148.0 147.0 147.0 147.0 148.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:30:18 INFO - PROCESS | 20631 | Values: 97.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:2.15 (3.3%) stddev-sans-first:2.28 17:30:18 INFO - PROCESS | 20631 | Values: 66.0 67.0 66.0 65.0 72.0 65.0 65.0 65.0 66.0 65.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 17:30:18 INFO - PROCESS | 20631 | Values: 64.0 64.0 64.0 64.0 66.0 65.0 65.0 66.0 65.0 65.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.50 stddev:2.04 (2.3%) stddev-sans-first:2.17 17:30:18 INFO - PROCESS | 20631 | Values: 87.0 88.0 86.0 86.0 85.0 88.0 92.0 85.0 87.0 88.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:144.50 stddev:7.20 (5.0%) stddev-sans-first:7.25 17:30:18 INFO - PROCESS | 20631 | Values: 139.0 144.0 138.0 142.0 155.0 141.0 151.0 145.0 159.0 140.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.00 stddev:1.23 (0.7%) stddev-sans-first:1.30 17:30:18 INFO - PROCESS | 20631 | Values: 174.0 173.0 174.0 175.0 174.0 173.0 175.0 177.0 173.0 174.0 17:30:18 INFO - PROCESS | 20631 | 17:30:18 INFO - PROCESS | 20631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:73.50 stddev:1.17 (1.6%) stddev-sans-first:0.87 17:30:18 INFO - PROCESS | 20631 | Values: 76.0 75.0 73.0 73.0 73.0 73.0 73.0 74.0 72.0 74.0 17:30:18 INFO - PROCESS | 20631 | -------- Summary: end -------- 17:30:18 INFO - PROCESS | 20631 | 17:30:19 INFO - TEST-INFO | 20631: exit 0 17:30:19 INFO - TEST-OK | kraken | took 62817ms 17:30:19 INFO - SUITE-END | took 1177s 17:30:19 INFO - Completed test suite (00:19:37) 17:30:19 INFO - javascript benchmark 17:30:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.486860062288, 2672.839629622222, 2704.2563295093832, 2710.024391219161, 2715.5247831629486, 4618.16872962867, 4632.143053535098, 4662.277347011214, 4671.649626278034, 4703.670743047988, 4618.861434156972, 4697.318888761128, 4764.237721964487, 4777.331173635694, 4781.737004464761, 4296.871093867181, 4326.524082350938, 4371.060222052258, 4386.078923426068, 4418.64650827933, 4347.347897815337, 4387.23223435899, 4421.491528474218, 4433.046894917592, 4436.334549817521, 4236.68224883135, 4282.4004639350205, 4300.032492689135, 4337.761423121727, 4355.825766969318, 4347.152305300468, 4358.520562738128, 4365.476142862877, 4366.0, 4376.277914144162, 4339.435873336478, 4339.5443478434945, 4344.391785150082, 4346.15250026245, 4399.626031787302, 4510.571495707935, 4581.0, 4634.86095417138, 4651.744154071558, 4651.86044418668, 4994.700317980933, 5016.523430274118, 5017.974910125426, 5036.622253331015, 5082.949170508322, 5057.69653820772, 5060.797568097271, 5063.569596584295, 5066.316047333599, 5136.152534831748, 4580.083983203339, 4663.930041049353, 4724.149653062482, 4739.597134243628, 4748.527956333548, 5127.359080114986, 5146.25379320004, 5160.458151893997, 5164.92252616211, 5186.974065129651, 4916.8770780730765, 4932.3022199323295, 4940.802367905316, 4959.429665588504, 4959.628027897922, 4890.926636100461, 4978.303037574742, 4994.825181118644, 5066.493350664904, 5074.06129865976, 4851.320815085891, 4932.580730637936, 4935.062338155739, 4940.505949405103, 4942.20924652054, 4899.951000490021, 4903.313536104948, 4905.607551395879, 4973.975130124326, 5039.3448851649055, 4229.851955181553, 4259.361095835588, 4261.169072030924, 4270.935935960963, 4305.6986010978935, 3621.9818900905852, 3644.6173151819207, 3721.106934335794, 3749.7937613431523, 3760.304343696425, 4423.800928958204, 4433.423654924839, 4435.889102772392, 4460.107978404332, 4479.372887795711, 4997.075541024922, 5057.595392368602, 5077.213031980049, 5085.389753229636, 5149.510796474329, 4327.221100201931, 4392.714473559208, 4421.867343979686, 4464.285714285698, 4475.239209334421, 4527.230370836965, 4535.183666939983, 4536.432945881765, 4540.614047805973, 4585.472670642852, 4707.0, 4735.337052812678, 4739.052189562032, 4749.192637251606, 4802.207635740064, 4891.070696567641, 5023.522765337287, 5068.82259120929, 5099.617528685438, 5143.897122057463, 4683.578477936866, 4734.526547345238, 4735.976320118515, 4738.952610473852, 4772.880677983078, 4843.104025755247, 4951.752412379438, 4953.826616068421, 4964.205727083649, 5021.07110184617, 5007.7245751484015, 5015.22264049073, 5023.6985780853265, 5073.695578265316, 5077.162268225849, 4844.442889067803, 4870.7808148632685, 4871.561559459666, 4877.341558889647, 4924.532169443897, 4772.665913386029, 4810.206315957827, 4819.903601927872, 4832.867897947345, 4922.1632322505975, 4741.146593613183, 4809.110314591811, 4810.230363142021, 4823.903521929612, 4834.540718631724, 4884.413870335582, 4901.387326584177, 4906.730129842893, 4916.901661966812, 4959.107360675113, 4672.48602653701, 4809.0862736080035, 4822.035592881368, 4827.782749776339, 4867.975660121677], "value": 4619.8656876249515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6431084106173, 590.5128269177928, 592.2419303291788, 607.2712744706353, 623.9625622462655, 25975.350616234602, 32513.837430812844, 33514.32971340578, 33554.832225838894, 33676.494852577234, 37732.81133594328, 38807.223855522876, 38923.026924326834, 39366.21267574654, 39382.80308598453, 7701.845963080735, 7880.330171935392, 7892.131865494791, 7899.763007109767, 7899.960500197491, 7684.615769211545, 7805.843883122334, 7812.3359514441345, 7831.2560306770765, 7841.568713720743, 7853.842923141562, 7895.131535531087, 7915.050193976731, 7922.405819563527, 7931.286184243417, 7816.648250828726, 7820.804479888048, 7829.138794732575, 7864.0, 7883.369330453578, 7720.7683769487, 7792.844143117162, 7817.648205830695, 7823.374130069581, 7842.098158711707, 35927.82036089829, 36480.0, 36540.81729591361, 36621.450678239846, 36630.63369366299, 3026.9243268918235, 3049.7560195184333, 3176.142441540794, 3436.896893093211, 3566.4293713006055, 26978.865105674347, 27021.324466888287, 27414.725852741416, 27909.150109113147, 28044.298892527648, 3476.8609255629744, 3487.3025394920865, 3503.1767534629344, 3581.0510214793103, 3614.7831130132013, 216735.0, 217338.0, 217595.99999999843, 217772.0, 219706.0, 32106.0, 51185.440727963454, 51809.740951295, 51846.74076629593, 51860.0, 31451.213719656735, 31482.527762083588, 31528.842355788533, 31645.683543164734, 31864.522032169534, 12641.494340226473, 12914.354282285849, 12923.935380323039, 12926.0, 12934.676633084247, 10397.63608273722, 10445.373277603216, 10463.110635595907, 10474.895251047545, 10502.05481506668, 7950.6422211000645, 8076.919230807616, 8162.102168761431, 8163.7142700005215, 8201.671933122609, 3148.842557872097, 3214.6785321468133, 3250.0, 3268.542404063433, 3289.5394644749754, 902.9413088149249, 902.9819403612022, 928.6424726480353, 940.5955439161227, 1015.7562185075676, 27398.354900090428, 27506.449871002467, 28049.859750701115, 28054.43891122166, 28563.57154642682, 963.7735132243918, 968.3173362779223, 1022.9181665466745, 1104.9005589496983, 1115.3976852499723, 13016.739665206644, 13346.666333341744, 13514.526991555249, 13541.39063742134, 13597.86402135966, 308064.0, 315835.0, 318563.0, 318794.0, 320424.0, 46670.0, 47375.28937065947, 47407.76296118566, 47821.76089119532, 47847.76076119667, 1207.2032458577296, 1250.4498020870788, 1260.9936950315189, 1267.6577324122436, 1282.8204051432806, 24328.0, 25488.235352939442, 25997.22008339753, 26345.736542634328, 26349.0, 39141.41287880741, 39619.80190099031, 39678.801605991786, 39880.800595996836, 40053.39919901145, 293530.0, 296622.0, 298475.0, 299036.0, 300184.0, 24623.50752984966, 24714.0, 25217.87391063033, 25253.747462525873, 25401.87299063493, 40149.799251003555, 40337.39493907535, 40459.3931091028, 40469.797651011555, 41113.0, 35053.29893402067, 35147.648523514436, 35167.296654067286, 35382.8230858844, 35449.82275088711, 34321.82839085789, 34464.310713786086, 34522.82738586291, 34594.13514662053, 35050.64949350474, 34680.65319346875, 35138.0, 35380.11549711175, 35815.28369432649, 37306.25387492181, 28216.15351539457, 30286.0, 30545.54181687321, 30768.230794230323, 30788.38423231478, 24259.272221833373, 24318.51362972766, 24446.14438494644, 24827.751722482542, 24831.503369932863], "value": 15945.338258644806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.98344074516643, 372.74653235799656, 378.4625831319526, 381.1367253171567, 395.08537735143125, 15526.767098493518, 15893.761593576091, 16522.421715239983, 16552.917235413806, 16681.582960425996, 14300.71398572028, 14987.0, 14990.700185996273, 14991.400343986228, 15000.174990375524, 4449.710768800026, 4854.708717476945, 4854.805807767685, 4855.271709243606, 4857.538533839297, 3423.0928803866996, 4742.2886567014875, 5140.408852981899, 5358.008768377863, 5383.111786555213, 5381.058314794915, 5402.513773760361, 5402.567794576444, 5418.160185171285, 5423.349198096214, 5273.630845840793, 5980.88038239235, 6086.665233412161, 6090.390960903918, 6104.236970378703, 5218.791248350061, 5390.056740070472, 5418.566514678816, 5440.156775699773, 5453.4273901240595, 12794.296313702742, 15114.54656360311, 20058.498537536532, 20172.899135504376, 20567.280145194847, 1769.5310742653207, 1884.1144662008971, 1886.4057821786093, 1930.1121484117323, 2037.1138554728593, 8878.422902511316, 9598.280128990353, 9600.90399096007, 12765.170263932907, 13441.126326788824, 1823.5441139715072, 1841.438361299803, 1860.1443336065427, 1868.4768264885854, 1883.8022007689133, 65335.67332163356, 66491.66754166246, 67361.0, 67797.0, 68849.65575172142, 9825.312228143961, 9916.702498925044, 10002.49987500622, 10012.949935250277, 10274.33216840903, 13977.860221397656, 13985.65035874091, 14043.438262469386, 14055.859441405455, 14102.576922692335, 6881.8967715484305, 7032.472564557678, 7141.357277845019, 7170.139583249939, 7228.337482379082, 6515.087887695727, 6520.673966301666, 6566.113574667359, 6670.266270710218, 6677.131972843499, 4309.159713855768, 4402.4056752338665, 4426.822927082881, 4431.667624928144, 4441.644668426518, 1780.910954452272, 1821.8360347568782, 1859.8884066956025, 1877.9295801393348, 1888.745019422388, 396.6885994494308, 402.20765092767203, 423.5975822968131, 834.9373796965252, 892.7991850960448, 10154.949225253975, 10264.846027309597, 10375.858655547883, 10459.372437653765, 10494.422806745702, 418.38915183831944, 436.75541696649975, 814.3322475570094, 894.9776255593532, 923.5290002098978, 8612.784680382916, 8698.0, 8760.211580957744, 8812.295016398673, 9107.134822191882, 389638.0, 406046.0, 416808.0, 421104.0, 421747.0, 75246.62376688082, 75543.62228188824, 76543.61728191323, 77072.0, 78136.60931695419, 968.8062387522524, 986.7187851462443, 1000.5092412305758, 1019.3985548526405, 1021.2238698589126, 14071.718565628425, 14431.134131951696, 15283.006604570668, 15325.233738313264, 15415.0, 30920.845395772878, 31468.370632587677, 32457.350852982338, 32557.18607034843, 33082.83458582692, 39236.41145382765, 39967.800161000174, 40033.399499006955, 40194.59805401909, 40307.0, 7728.4590078693955, 7833.1775163607, 7865.567393793396, 8077.717279895175, 8092.433529652868, 8754.25588824957, 10290.485475726035, 10323.174146068446, 11693.707657308636, 11836.230645008047, 9797.363171393836, 10250.282480226313, 10291.588336466757, 10322.0, 10509.9474502627, 10171.593136274467, 10176.18590512772, 10404.0, 10547.78904421892, 10801.837972430263, 10099.79800403973, 10267.646898438827, 10736.30214036085, 10856.674299771019, 10893.56425742993, 7404.925950740424, 7813.14055453911, 7912.248336408032, 7948.244916732901, 8211.753647390588, 9708.368956017835, 10790.369091689176, 10792.784144317227, 10951.178661600572, 11110.555577777122], "value": 7841.203506932045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.1507925403266, 1476.6234610174404, 1574.4253347528156, 1769.8849574777646, 1801.837834594887, 6725.798226053214, 7361.521501102425, 7452.7391541296065, 7652.885206721897, 7690.692372305115, 7408.59252741099, 7495.962520187391, 7513.098428188625, 7573.318401343878, 7583.393328533718, 2174.8803815790125, 2190.868547887124, 2198.505336299336, 2204.4488877780555, 2210.35899589119, 2155.91376344946, 2184.224600266898, 2261.389424855288, 2266.9319920402413, 2269.1604106480545, 2199.49411635324, 2227.40973641985, 2227.4208705736546, 2252.650839119939, 2281.543691261746, 2120.703101565782, 2134.583756167548, 2150.311900191939, 2152.257471172443, 2158.298552970275, 2211.590855691686, 2260.3219034289646, 2274.3972847195505, 2279.566882292359, 2283.897224624896, 7620.390368770485, 7629.198934111894, 7692.0384951881015, 7694.422918281151, 7747.418943579254, 4386.912261754779, 4553.339765733983, 4555.521670224612, 4559.0, 4579.290210017452, 2795.343094372821, 2882.0489238551227, 2885.2642576143157, 2936.07513633207, 2952.9557056644167, 953.0945601678433, 957.2389949989774, 975.3465178330536, 977.3988996767008, 982.2289502740315, 9880.0, 9930.602775888956, 9954.303198776088, 10019.04819042197, 10038.548265328005, 4067.613576710208, 4081.8775436736946, 4199.769012704331, 4289.82840686369, 4298.677599180074, 8556.0, 8612.397132200686, 8624.568771561397, 8637.784055398539, 8646.43798153118, 4556.476005259371, 4560.156371071296, 4587.197240482902, 4590.609798167193, 4604.677672562955, 3667.5598928128798, 4081.2653722330265, 4181.268278051329, 4189.706720529594, 4210.6841986850495, 3582.194006348551, 3621.348157331706, 3695.981520092382, 3714.294284086015, 3739.8691045813266, 1240.925544467335, 1251.3117785218276, 1256.0579565326007, 1264.7217612125319, 1268.239056566053, 919.7562645898843, 940.1350757303297, 942.8020115775627, 976.5995941663883, 1254.1659796235401, 7022.508424410345, 7036.718531258794, 7047.859042819115, 7063.04648872406, 7229.385502232369, 430.5952404739535, 448.20220008385127, 457.9152856721517, 460.07754452322877, 460.1854717150625, 5404.054290499147, 5422.240886275925, 5437.673739575638, 5459.727013649302, 5466.480684334982, 8985.146411090936, 9369.156775890202, 9431.952840235756, 9443.90556094444, 9515.381500202464, 9142.954285228532, 9273.953630231807, 9303.953480232556, 9337.393069450463, 9411.294152938557, 7196.244394338623, 7251.528650637797, 7256.854862902818, 7331.670074846645, 7344.155422126524, 6907.6891539881835, 7022.332878376546, 7077.044598979072, 7091.60996145217, 7093.964530177316, 8585.785355365915, 8671.696490622799, 8885.955570222108, 8914.910850891409, 8921.776955576162, 8549.14508549165, 8554.871676924726, 8745.125487451458, 8817.426867253607, 8847.336449766164, 6027.849303767441, 6163.322034576283, 6339.270983836734, 6539.11721917554, 6698.698558564974, 6889.896651550331, 6906.482013849082, 6943.826404339729, 6963.2340442552295, 6969.616671083139, 6187.443130118311, 6416.358364163546, 6427.357264273535, 6485.3514648534765, 6531.869362612626, 6346.90479642815, 6476.287608362982, 6508.414242718178, 6560.442362399059, 6701.530892837454, 6828.897566536407, 6876.381125698711, 6895.724171033103, 6906.171259448898, 6908.620025898624, 6145.262568491809, 6196.225471816023, 6258.155149055002, 6302.905456418066, 6312.116303717391, 6227.875442491216, 6249.6562689052535, 6265.028920517327, 6281.623102613858, 6298.968505157445], "value": 4251.396255854645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.68001278670187, 312.5639732573061, 315.03127881763584, 318.0331791354283, 318.21559854957525, 5286.947130528693, 5398.81104161355, 5399.272232885473, 5431.728413579315, 5432.619716619838, 5292.444293349201, 5337.946620533793, 5340.25236466895, 5343.0, 5344.412114667393, 3925.15609144034, 4044.8786536403954, 4157.127003329305, 4161.981439002082, 4189.706720529556, 4175.185838761443, 4190.685698572604, 4200.411942328076, 4204.474440694913, 4210.157968406331, 4186.079062606222, 4187.016051227959, 4187.979060104695, 4192.149338449853, 4206.47419072616, 4097.282975479279, 4177.624013838738, 4183.205191013728, 4188.6439652629415, 4189.308764053927, 3671.724620653435, 3673.6326367363317, 3676.871309504181, 3677.2093999789904, 3682.4660424238336, 5128.743562821844, 5132.153194722866, 5142.820001299974, 5152.278680984665, 5154.664946778447, 4707.411573553306, 4792.9281060784115, 4805.087033463666, 4805.975970120162, 4817.458413307743, 5573.27547418833, 5594.356648985378, 5619.297587801525, 5624.29696287964, 5651.8304450866535, 4000.239954408653, 4000.4599379084034, 4020.5376381716183, 4022.0, 4034.132661477767, 5742.856428589277, 5920.437558431985, 5956.880862382728, 5968.104784282349, 5986.700664966777, 4121.381792731055, 4148.979255103705, 4149.460570125864, 4150.107726838744, 4158.168366326747, 4189.308764053897, 4198.223328684203, 4202.495700515897, 4207.705460617727, 4216.810243539048, 4628.722276663411, 4807.831725889647, 4809.182438985381, 4809.807607695653, 4812.013537224861, 5576.804811831647, 5656.377798442168, 5658.321001479767, 5672.347680016851, 5693.637140586693, 1436.4182506085053, 1444.4222311075655, 1458.3947661720267, 1461.4811741831709, 1464.9818376228418, 930.6277489004317, 972.2027937091658, 991.5686676295834, 1008.1732978957185, 1012.8025035118228, 4854.781534830941, 4998.775055122455, 5022.472640372781, 5039.82360617384, 5040.470750571138, 5894.0, 5900.527957763368, 5920.542974665465, 5926.436988486087, 5929.288485381696, 4866.294387313819, 4999.0, 5026.874328141826, 5052.747362631853, 5081.822136225214, 3126.89055883043, 3159.9572141193353, 3165.1454107390878, 3165.9710594057024, 3171.2864605463587, 5472.534834539029, 5509.3664228613425, 5512.255845460892, 5523.696196709219, 5532.948739739437, 5740.856478587985, 6001.3098493672915, 6080.422359875804, 6093.11649810775, 6099.603525770811, 5478.315210598676, 5482.890342193134, 5510.410107249586, 5523.861903452365, 5538.944610553924, 5772.614572502654, 5864.624826945094, 5897.439743224387, 5897.64614123154, 5898.557608179318, 5772.018756811436, 5789.942100579109, 5796.1305804129715, 5801.650331615702, 5821.563382746395, 5487.314085739283, 5527.088030474926, 5528.7235638218735, 5530.479118242515, 5555.0834112371, 3979.0649197439157, 4027.677785777072, 4032.0, 4046.5548789632526, 4051.9797401013984, 5875.794347197828, 5878.676672782867, 5904.844731672994, 5910.1725758392995, 5918.2898052234, 5714.857128571819, 5728.3412407572, 5728.914066288926, 5744.569157313134, 5761.769529218785, 5429.375621803543, 5743.167240749985, 5760.423957604206, 5762.164486149569, 5767.942320576741, 5262.315898933114, 5629.437056294338, 5644.971775141098, 5666.17840413146, 5667.376588575171, 5544.500994910478, 5666.575006874418, 5706.172604972173, 5739.368669446274, 5757.5681823864215, 5560.443955604407, 5590.468905453975, 5617.943820561905, 5618.88762224745, 5626.127950167567], "value": 4267.165861675732, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.7698982346002, 706.77383237364, 722.4798145335359, 745.3738859358139, 751.3388218367837, 10150.74623134422, 10693.465326733662, 10883.673489795308, 11509.136814738886, 12156.939215303933, 13482.460701571925, 13508.93245533771, 13598.660033499144, 13604.387802548885, 13608.455661773518, 641.0576452614672, 798.4530596541359, 821.322409012564, 824.4105464592815, 825.2531459029587, 810.3152835853724, 812.0215140755375, 812.743985644523, 813.9145389734082, 816.3346872299057, 846.3821410370433, 848.2704873808519, 849.1550906847664, 850.306999795168, 851.29342645604, 843.7890527368158, 844.1558441558442, 845.6406027438345, 847.9830403391928, 848.2747251100282, 621.2638023941644, 621.710904429438, 622.7260005597568, 622.9159063526412, 623.2147494157394, 11387.772244555063, 11431.085513158927, 11468.71328216793, 11473.311601303865, 11491.827622585668, 12694.0, 12954.740905181938, 13041.934790326082, 13086.86913130866, 13203.603891883258, 10286.434246116462, 10327.483625818679, 10428.21788365868, 10525.21060920434, 10653.893461065367, 3386.204242003127, 3406.5741782277214, 3444.3627928832993, 3448.103493091789, 3456.602490713575, 48604.27093593599, 48806.26790598144, 49957.25064124041, 50020.74989625029, 50174.0, 10248.333858299187, 10336.793264134676, 10339.121174700234, 10366.896331036744, 10457.84313235302, 17495.825041749675, 18809.717854232196, 18833.43499694984, 18874.62250754977, 18918.527036823914, 6579.342065793382, 6585.275619681831, 6719.0593316935665, 6734.292899245606, 6804.285550017276, 3553.893383198508, 3643.198496330803, 3663.9816800915823, 3689.6494832990825, 3748.0817199785683, 2758.5724212747054, 2863.7565806906227, 2867.641544806899, 2876.0, 3175.968240317567, 556.3574071946908, 567.3617180671745, 570.0736303506801, 572.8796952639992, 578.8466056495032, 620.5687047502033, 626.3736263736264, 640.484410049905, 641.685574068703, 646.1309538670481, 7459.254074592606, 7755.379569634416, 8004.719834805754, 8208.343332533383, 8244.917550824535, 583.9591228614041, 614.883172197281, 616.315889362807, 624.4411251929498, 632.4023797511308, 3837.213371258885, 3879.612038796154, 3989.6409323161056, 4279.850205242864, 4312.913741725148, 51509.48490515122, 52541.110238937224, 52581.0, 52717.209241861405, 54016.72991635095, 43481.56518434839, 45730.771346143054, 46615.53384466112, 46788.0, 48376.0, 43562.56437435649, 45053.269406712476, 45229.77385113119, 45424.77287613607, 45538.77230613826, 8172.713955011546, 8222.17778222173, 8237.711680091168, 8250.587470626564, 8356.832863342821, 28495.715042849308, 28718.856405717837, 28858.134255972356, 28879.85560072186, 29029.419411611227, 37403.2519349606, 38087.61912380841, 39975.60024399835, 40345.1930961385, 40593.0, 10602.363858168535, 10626.36241825493, 10779.083777878968, 10794.082502987334, 10811.459427028774, 11687.76624467489, 11842.171048026556, 11982.221155624857, 12062.336571488653, 12296.692582685504, 11795.351255680676, 11974.161808673309, 12181.33002684861, 12362.690932726753, 12376.81434778497, 10536.420496872746, 10852.348859068481, 10885.673429797118, 10945.616903408662, 11912.166148369532, 10924.749554238651, 11045.668629941114, 11140.888591113986, 11443.713907152387, 11653.941730291293, 9418.95290523543, 9570.521473926416, 9588.280878933969, 9836.950815245878, 9889.307748457539, 9405.717828465156, 9651.557353769223, 9698.85451718239, 9744.17174540172, 9748.61347646276], "value": 6059.976691605534, "unit": "score"}], "name": "dromaeo_css", "value": 6316.423754371136, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 115.0, 113.0, 115.0, 128.0, 116.0, 114.0, 114.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 133.0, 156.0, 176.0, 135.0, 168.0, 162.0, 136.0, 191.0, 136.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 164.0, 163.0, 164.0, 174.0, 165.0, 164.0, 166.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 77.0, 72.0, 75.0, 73.0, 152.0, 74.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 133.0, 94.0, 96.0, 94.0, 138.0, 94.0, 96.0, 139.0], "value": 107.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 72.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 86.0, 86.0, 85.0, 88.0, 92.0, 85.0, 87.0, 88.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 144.0, 138.0, 142.0, 155.0, 141.0, 151.0, 145.0, 159.0, 140.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 174.0, 175.0, 174.0, 173.0, 175.0, 177.0, 173.0, 174.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 73.0, 73.0, 73.0, 73.0, 73.0, 74.0, 72.0, 74.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1598.5, "alertThreshold": 2.0}]} 17:30:19 INFO - Return code: 0 17:30:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:30:19 ERROR - # TBPL SUCCESS # 17:30:19 INFO - Running post-action listener: _resource_record_post_action 17:30:19 INFO - Running post-run listener: _resource_record_post_run 17:30:20 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 288096256; Read time: 0; Write time: 223128 17:30:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 9617408; Read time: 0; Write time: 9016 17:30:20 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 278478848; Read time: 0; Write time: 214112 17:30:20 INFO - Running post-run listener: _upload_blobber_files 17:30:20 INFO - Blob upload gear active. 17:30:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:30:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:30:20 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:30:20 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:30:22 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:30:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:30:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:28 INFO - (blobuploader) - INFO - Done attempting. 17:30:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:30:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:32 INFO - (blobuploader) - INFO - Done attempting. 17:30:32 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:32 INFO - Return code: 0 17:30:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffda0bc0ad3eb3fd4ba7e1650dd2eaeca0bbd469a028bce1750a3eb009d1bbdd97ec5e570fe2b4ea8908d817dacbc35d1af664ea5c558b5cc0f07d3f60bb80ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2979b6173e52afffde6b455a7bc98c4e2676ebec6a250dab196e2b60d130a89d49bc578d8e0d555eec2b161d62699fda3254527cc1c6f86bdd0ece8d7f361432"} 17:30:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:32 INFO - Contents: 17:30:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffda0bc0ad3eb3fd4ba7e1650dd2eaeca0bbd469a028bce1750a3eb009d1bbdd97ec5e570fe2b4ea8908d817dacbc35d1af664ea5c558b5cc0f07d3f60bb80ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2979b6173e52afffde6b455a7bc98c4e2676ebec6a250dab196e2b60d130a89d49bc578d8e0d555eec2b161d62699fda3254527cc1c6f86bdd0ece8d7f361432"} 17:30:32 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:32 INFO - Copying logs to upload dir... 17:30:32 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.899188 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-08 17:30:32.432026) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 17:30:32.436125) ========= 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=6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441 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/Firefox-Non-PGO/sha512/ffda0bc0ad3eb3fd4ba7e1650dd2eaeca0bbd469a028bce1750a3eb009d1bbdd97ec5e570fe2b4ea8908d817dacbc35d1af664ea5c558b5cc0f07d3f60bb80ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2979b6173e52afffde6b455a7bc98c4e2676ebec6a250dab196e2b60d130a89d49bc578d8e0d555eec2b161d62699fda3254527cc1c6f86bdd0ece8d7f361432"} build_url:https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/IQFqaeXeTPupREnX_8JCeA/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/Firefox-Non-PGO/sha512/ffda0bc0ad3eb3fd4ba7e1650dd2eaeca0bbd469a028bce1750a3eb009d1bbdd97ec5e570fe2b4ea8908d817dacbc35d1af664ea5c558b5cc0f07d3f60bb80ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2979b6173e52afffde6b455a7bc98c4e2676ebec6a250dab196e2b60d130a89d49bc578d8e0d555eec2b161d62699fda3254527cc1c6f86bdd0ece8d7f361432"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 17:30:32.465483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:30:32.466285) ========= 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=6dbc10da6d83fee962c624be000001a8-1460158246.313947-1572557441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:30:32.550782) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 17:30:32.551553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 17:30:32.552065) ========= ========= Total master_lag: 0.44 =========