builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1456527486.88 results: success (0) buildid: 20160226132930 builduid: d613a3816d7d497f8b6deeeebe3fd863 revision: 139446b09ca7f9dd05ad11ca8db9103b90aa69b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.876108) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.876606) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.876897) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009141 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.900679) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.901002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.914968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.915409) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.964313) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.964668) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.965081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:06.965383) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 14:58:07-- 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% 43.9M=0s 2016-02-26 14:58:07 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:07.151711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:07.151987) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014226 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:07.201165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:07.201541) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 139446b09ca7f9dd05ad11ca8db9103b90aa69b2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 139446b09ca7f9dd05ad11ca8db9103b90aa69b2 --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=9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 14:58:07,411 truncating revision to first 12 chars 2016-02-26 14:58:07,411 Setting DEBUG logging. 2016-02-26 14:58:07,411 attempt 1/10 2016-02-26 14:58:07,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/139446b09ca7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 14:58:07,683 unpacking tar archive at: fx-team-139446b09ca7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.582085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:07.796589) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:07.796970) ========= echo 139446b09ca7f9dd05ad11ca8db9103b90aa69b2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'139446b09ca7f9dd05ad11ca8db9103b90aa69b2'] 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=9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 139446b09ca7f9dd05ad11ca8db9103b90aa69b2 program finished with exit code 0 elapsedTime=0.004705 script_repo_revision: '139446b09ca7f9dd05ad11ca8db9103b90aa69b2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:07.848038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:07.848387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 14:58:07.857939) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-26 14:58:07.858241) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:58:08 INFO - MultiFileLogger online at 20160226 14:58:08 in /builds/slave/test 14:58:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:58:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:58:08 INFO - {'append_to_log': False, 14:58:08 INFO - 'base_work_dir': '/builds/slave/test', 14:58:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:58:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:58:08 INFO - 'branch': 'Fx-Team-Non-PGO', 14:58:08 INFO - 'buildbot_json_path': 'buildprops.json', 14:58:08 INFO - 'config_files': ('talos/linux_config.py',), 14:58:08 INFO - 'default_actions': ('clobber', 14:58:08 INFO - 'read-buildbot-config', 14:58:08 INFO - 'download-and-extract', 14:58:08 INFO - 'populate-webroot', 14:58:08 INFO - 'create-virtualenv', 14:58:08 INFO - 'install', 14:58:08 INFO - 'run-tests'), 14:58:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:58:08 INFO - 'download_minidump_stackwalk': True, 14:58:08 INFO - 'download_symbols': 'ondemand', 14:58:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:58:08 INFO - 'tooltool.py': '/tools/tooltool.py', 14:58:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:58:08 INFO - '/tools/misc-python/virtualenv.py')}, 14:58:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:58:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:58:08 INFO - 'installer_path': 'installer.exe', 14:58:08 INFO - 'log_level': 'info', 14:58:08 INFO - 'log_name': 'talos', 14:58:08 INFO - 'log_to_console': True, 14:58:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:58:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:58:08 INFO - 'opt_config_files': (), 14:58:08 INFO - 'pip_index': False, 14:58:08 INFO - 'sps_profile': False, 14:58:08 INFO - 'sps_profile_interval': 0, 14:58:08 INFO - 'suite': 'dromaeojs-e10s', 14:58:08 INFO - 'system_bits': '32', 14:58:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:58:08 INFO - 'title': 'talos-linux64-ix-022', 14:58:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:58:08 INFO - 'use_talos_json': True, 14:58:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:58:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:58:08 INFO - 'work_dir': 'build'} 14:58:08 INFO - ##### 14:58:08 INFO - ##### Running clobber step. 14:58:08 INFO - ##### 14:58:08 INFO - Running pre-action listener: _resource_record_pre_action 14:58:08 INFO - Running main action method: clobber 14:58:08 INFO - rmtree: /builds/slave/test/build 14:58:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:58:08 INFO - Running post-action listener: _resource_record_post_action 14:58:08 INFO - ##### 14:58:08 INFO - ##### Running read-buildbot-config step. 14:58:08 INFO - ##### 14:58:08 INFO - Running pre-action listener: _resource_record_pre_action 14:58:08 INFO - Running main action method: read_buildbot_config 14:58:08 INFO - Using buildbot properties: 14:58:08 INFO - { 14:58:08 INFO - "project": "", 14:58:08 INFO - "product": "firefox", 14:58:08 INFO - "script_repo_revision": "production", 14:58:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:58:08 INFO - "repository": "", 14:58:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:58:08 INFO - "buildid": "20160226132930", 14:58:08 INFO - "pgo_build": "False", 14:58:08 INFO - "basedir": "/builds/slave/test", 14:58:08 INFO - "buildnumber": 905, 14:58:08 INFO - "slavename": "talos-linux64-ix-022", 14:58:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:58:08 INFO - "platform": "ubuntu64_hw", 14:58:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:58:08 INFO - "branch": "fx-team", 14:58:08 INFO - "repo_path": "integration/fx-team", 14:58:08 INFO - "revision": "139446b09ca7f9dd05ad11ca8db9103b90aa69b2", 14:58:08 INFO - "stage_platform": "linux64", 14:58:08 INFO - "builduid": "d613a3816d7d497f8b6deeeebe3fd863", 14:58:08 INFO - "slavebuilddir": "test" 14:58:08 INFO - } 14:58:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 14:58:08 INFO - Running post-action listener: _resource_record_post_action 14:58:08 INFO - ##### 14:58:08 INFO - ##### Running download-and-extract step. 14:58:08 INFO - ##### 14:58:08 INFO - Running pre-action listener: _resource_record_pre_action 14:58:08 INFO - Running main action method: download_and_extract 14:58:08 INFO - mkdir: /builds/slave/test/build/tests 14:58:08 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')]} 14:58:08 INFO - https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:58:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/test_packages.json 14:58:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/test_packages.json 14:58:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:58:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:58:09 INFO - Downloaded 1448 bytes. 14:58:09 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:58:09 INFO - Using the following test package requirements: 14:58:09 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:58:09 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:58:09 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:58:09 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:09 INFO - u'jsshell-linux-x86_64.zip'], 14:58:09 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:58:09 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:58:09 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:58:09 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:58:09 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:58:09 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:58:09 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:58:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:58: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')]} 14:58:09 INFO - https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:58:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:58:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:58:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:58:11 INFO - Downloaded 22056809 bytes. 14:58:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:58:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:58:12 INFO - Return code: 0 14:58:12 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:12 INFO - https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:58:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:58:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:58:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:58:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:58:17 INFO - Downloaded 22056809 bytes. 14:58:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:58:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:58:19 INFO - Return code: 0 14:58:19 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')]} 14:58:19 INFO - https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:58:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:58:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:58:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:58:20 INFO - Downloaded 10713410 bytes. 14:58:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:58:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:58:20 INFO - Return code: 0 14:58: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')]} 14:58:20 INFO - https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:58:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:58:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:58:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:58:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:58:23 INFO - Downloaded 54830067 bytes. 14:58:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:58:23 INFO - mkdir: /builds/slave/test/properties 14:58:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:58:23 INFO - Writing to file /builds/slave/test/properties/build_url 14:58:23 INFO - Contents: 14:58:23 INFO - build_url:https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:58:24 INFO - Running post-action listener: _resource_record_post_action 14:58:24 INFO - Running post-action listener: set_extra_try_arguments 14:58:24 INFO - ##### 14:58:24 INFO - ##### Running populate-webroot step. 14:58:24 INFO - ##### 14:58:24 INFO - Running pre-action listener: _resource_record_pre_action 14:58:24 INFO - Running main action method: populate_webroot 14:58:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:58:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:58:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:58:24 INFO - '--tppagecycles', 14:58:24 INFO - '7'], 14:58:24 INFO - 'tests': ['tsvgm']}}, 14:58:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:58:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:58:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:58:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:58:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:58:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:58:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:58:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:24 INFO - 'talos_options': ['--e10s'], 14:58:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:58:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:24 INFO - 'tests': ['damp', 'tps']}, 14:58:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:24 INFO - 'talos_options': ['--e10s'], 14:58:24 INFO - 'tests': ['damp', 'tps']}, 14:58:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:58:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:58:24 INFO - 'other': {'tests': ['a11yr', 14:58:24 INFO - 'ts_paint', 14:58:24 INFO - 'tpaint', 14:58:24 INFO - 'sessionrestore', 14:58:24 INFO - 'sessionrestore_no_auto_restore']}, 14:58:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:58:24 INFO - 'tests': ['a11yr', 14:58:24 INFO - 'ts_paint', 14:58:24 INFO - 'tpaint', 14:58:24 INFO - 'sessionrestore', 14:58:24 INFO - 'sessionrestore_no_auto_restore']}, 14:58:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:58:24 INFO - 'tests': ['a11yr', 14:58:24 INFO - 'ts_paint', 14:58:24 INFO - 'tpaint', 14:58:24 INFO - 'sessionrestore', 14:58:24 INFO - 'sessionrestore_no_auto_restore']}, 14:58:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:58:24 INFO - 'tests': ['a11yr', 14:58:24 INFO - 'ts_paint', 14:58:24 INFO - 'tpaint', 14:58:24 INFO - 'sessionrestore', 14:58:24 INFO - 'sessionrestore_no_auto_restore']}, 14:58:24 INFO - 'other_l64': {'tests': ['a11yr', 14:58:24 INFO - 'ts_paint', 14:58:24 INFO - 'tpaint', 14:58:24 INFO - 'sessionrestore', 14:58:24 INFO - 'sessionrestore_no_auto_restore']}, 14:58:24 INFO - 'other_nol64': {'tests': ['a11yr', 14:58:24 INFO - 'ts_paint', 14:58:24 INFO - 'tpaint', 14:58:24 INFO - 'sessionrestore', 14:58:24 INFO - 'sessionrestore_no_auto_restore']}, 14:58:24 INFO - 'svgr': {'tests': ['tsvgx', 14:58:24 INFO - 'tsvgr_opacity', 14:58:24 INFO - 'tart', 14:58:24 INFO - 'tscrollx', 14:58:24 INFO - 'cart']}, 14:58:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:58:24 INFO - 'tests': ['tsvgx', 14:58:24 INFO - 'tsvgr_opacity', 14:58:24 INFO - 'tart', 14:58:24 INFO - 'tscrollx', 14:58:24 INFO - 'cart']}, 14:58:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:24 INFO - 'tests': ['tp5o']}, 14:58:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:24 INFO - 'talos_options': ['--e10s'], 14:58:24 INFO - 'tests': ['tp5o']}, 14:58:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:24 INFO - 'talos_options': ['--xperf_path', 14:58:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:58:24 INFO - 'tests': ['tp5n']}, 14:58:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:24 INFO - 'talos_options': ['--e10s', 14:58:24 INFO - '--xperf_path', 14:58:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:58:24 INFO - 'tests': ['tp5n']}}, 14:58:24 INFO - 'talos.zip': {'path': '', 14:58:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:58:24 INFO - Running post-action listener: _resource_record_post_action 14:58:24 INFO - ##### 14:58:24 INFO - ##### Running create-virtualenv step. 14:58:24 INFO - ##### 14:58:24 INFO - Running pre-action listener: _resource_record_pre_action 14:58:24 INFO - Running main action method: create_virtualenv 14:58:24 INFO - Creating virtualenv /builds/slave/test/build/venv 14:58:24 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 14:58:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:58:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:58:24 INFO - Using real prefix '/usr' 14:58:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:58:24 INFO - Installing distribute.............................................................................................................................................................................................done. 14:58:26 INFO - Installing pip.................done. 14:58:26 INFO - Return code: 0 14:58:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31f166ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826100>, '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 0x2827000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2827490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', '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 14:58:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:58:26 INFO - Using env: {'DISPLAY': ':0', 14:58:26 INFO - 'HOME': '/home/cltbld', 14:58:26 INFO - 'LANG': 'en_US.UTF-8', 14:58:26 INFO - 'LANGUAGE': 'en_US:en', 14:58:26 INFO - 'LOGNAME': 'cltbld', 14:58:26 INFO - 'MAIL': '/var/mail/cltbld', 14:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:26 INFO - 'MOZ_NO_REMOTE': '1', 14:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:26 INFO - 'NO_EM_RESTART': '1', 14:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:26 INFO - 'PWD': '/builds/slave/test', 14:58:26 INFO - 'SHELL': '/bin/bash', 14:58:26 INFO - 'SHLVL': '1', 14:58:26 INFO - 'TERM': 'linux', 14:58:26 INFO - 'TMOUT': '86400', 14:58:26 INFO - 'USER': 'cltbld', 14:58:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', 14:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:26 INFO - '_': '/tools/buildbot/bin/python'} 14:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:26 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 14:58:26 INFO - Cleaning up... 14:58:26 INFO - Return code: 0 14:58:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f31f166ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826100>, '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 0x2827000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2827490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', '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 14:58:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:58:26 INFO - Using env: {'DISPLAY': ':0', 14:58:26 INFO - 'HOME': '/home/cltbld', 14:58:26 INFO - 'LANG': 'en_US.UTF-8', 14:58:26 INFO - 'LANGUAGE': 'en_US:en', 14:58:26 INFO - 'LOGNAME': 'cltbld', 14:58:26 INFO - 'MAIL': '/var/mail/cltbld', 14:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:26 INFO - 'MOZ_NO_REMOTE': '1', 14:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:26 INFO - 'NO_EM_RESTART': '1', 14:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:26 INFO - 'PWD': '/builds/slave/test', 14:58:26 INFO - 'SHELL': '/bin/bash', 14:58:26 INFO - 'SHLVL': '1', 14:58:26 INFO - 'TERM': 'linux', 14:58:26 INFO - 'TMOUT': '86400', 14:58:27 INFO - 'USER': 'cltbld', 14:58:27 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', 14:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:27 INFO - '_': '/tools/buildbot/bin/python'} 14:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:27 INFO - Downloading/unpacking psutil>=0.7.1 14:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:58:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:58:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:58:29 INFO - Installing collected packages: psutil 14:58:29 INFO - Running setup.py install for psutil 14:58:29 INFO - building 'psutil._psutil_linux' extension 14:58:29 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 14:58:29 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 14:58:29 INFO - building 'psutil._psutil_posix' extension 14:58:29 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 14:58:29 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 14:58:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:58:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:58:29 INFO - Successfully installed psutil 14:58:29 INFO - Cleaning up... 14:58:29 INFO - Return code: 0 14:58:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:58:29 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')]} 14:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:29 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')]} 14:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:29 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 0x7f31f166ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826100>, '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 0x2827000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2827490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', '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 14:58:29 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 14:58:29 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 14:58:29 INFO - Using env: {'DISPLAY': ':0', 14:58:29 INFO - 'HOME': '/home/cltbld', 14:58:29 INFO - 'LANG': 'en_US.UTF-8', 14:58:29 INFO - 'LANGUAGE': 'en_US:en', 14:58:29 INFO - 'LOGNAME': 'cltbld', 14:58:29 INFO - 'MAIL': '/var/mail/cltbld', 14:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:29 INFO - 'MOZ_NO_REMOTE': '1', 14:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:29 INFO - 'NO_EM_RESTART': '1', 14:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:29 INFO - 'PWD': '/builds/slave/test', 14:58:29 INFO - 'SHELL': '/bin/bash', 14:58:29 INFO - 'SHLVL': '1', 14:58:29 INFO - 'TERM': 'linux', 14:58:29 INFO - 'TMOUT': '86400', 14:58:29 INFO - 'USER': 'cltbld', 14:58:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', 14:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:29 INFO - '_': '/tools/buildbot/bin/python'} 14:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:58:31 INFO - Installing collected packages: mozsystemmonitor 14:58:31 INFO - Running setup.py install for mozsystemmonitor 14:58:31 INFO - Successfully installed mozsystemmonitor 14:58:31 INFO - Cleaning up... 14:58:31 INFO - Return code: 0 14:58:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:31 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 0x7f31f166ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826100>, '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 0x2827000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2827490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', '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 14:58:31 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 14:58:31 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 14:58:31 INFO - Using env: {'DISPLAY': ':0', 14:58:31 INFO - 'HOME': '/home/cltbld', 14:58:31 INFO - 'LANG': 'en_US.UTF-8', 14:58:31 INFO - 'LANGUAGE': 'en_US:en', 14:58:31 INFO - 'LOGNAME': 'cltbld', 14:58:31 INFO - 'MAIL': '/var/mail/cltbld', 14:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:31 INFO - 'MOZ_NO_REMOTE': '1', 14:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:31 INFO - 'NO_EM_RESTART': '1', 14:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:31 INFO - 'PWD': '/builds/slave/test', 14:58:31 INFO - 'SHELL': '/bin/bash', 14:58:31 INFO - 'SHLVL': '1', 14:58:31 INFO - 'TERM': 'linux', 14:58:31 INFO - 'TMOUT': '86400', 14:58:31 INFO - 'USER': 'cltbld', 14:58:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', 14:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:31 INFO - '_': '/tools/buildbot/bin/python'} 14:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:32 INFO - Downloading/unpacking blobuploader==1.2.4 14:58:32 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 14:58:32 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 14:58:32 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 14:58:32 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 14:58:32 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 14:58:32 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 14:58:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:58:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:58:34 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 14:58:34 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 14:58:34 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 14:58:34 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 14:58:34 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 14:58:34 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 14:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:58:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:58:34 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 14:58:34 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 14:58:34 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 14:58:34 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 14:58:34 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 14:58:34 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 14:58:34 INFO - Downloading docopt-0.6.1.tar.gz 14:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:58:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:58:34 INFO - Running setup.py install for blobuploader 14:58:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:58:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:58:34 INFO - Running setup.py install for requests 14:58:35 INFO - Running setup.py install for docopt 14:58:35 INFO - Successfully installed blobuploader requests docopt 14:58:35 INFO - Cleaning up... 14:58:35 INFO - Return code: 0 14:58:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:35 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 0x7f31f166ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826100>, '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 0x2827000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2827490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', '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 14:58:35 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 14:58:35 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 14:58:35 INFO - Using env: {'DISPLAY': ':0', 14:58:35 INFO - 'HOME': '/home/cltbld', 14:58:35 INFO - 'LANG': 'en_US.UTF-8', 14:58:35 INFO - 'LANGUAGE': 'en_US:en', 14:58:35 INFO - 'LOGNAME': 'cltbld', 14:58:35 INFO - 'MAIL': '/var/mail/cltbld', 14:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:35 INFO - 'MOZ_NO_REMOTE': '1', 14:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:35 INFO - 'NO_EM_RESTART': '1', 14:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:35 INFO - 'PWD': '/builds/slave/test', 14:58:35 INFO - 'SHELL': '/bin/bash', 14:58:35 INFO - 'SHLVL': '1', 14:58:35 INFO - 'TERM': 'linux', 14:58:35 INFO - 'TMOUT': '86400', 14:58:35 INFO - 'USER': 'cltbld', 14:58:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', 14:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:35 INFO - '_': '/tools/buildbot/bin/python'} 14:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:58:35 INFO - Running setup.py (path:/tmp/pip-jff8pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:58:35 INFO - Running setup.py (path:/tmp/pip-62WVK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:58:35 INFO - Running setup.py (path:/tmp/pip-D4dcbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:58:35 INFO - Running setup.py (path:/tmp/pip-DUz8yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:58:35 INFO - Running setup.py (path:/tmp/pip-_Q5vmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:58:35 INFO - Running setup.py (path:/tmp/pip-AYO1LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:58:36 INFO - Running setup.py (path:/tmp/pip-UF1aNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:58:36 INFO - Running setup.py (path:/tmp/pip-c0W4Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:58:36 INFO - Running setup.py (path:/tmp/pip-fMj9OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:58:36 INFO - Running setup.py (path:/tmp/pip-0Fykua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:58:36 INFO - Running setup.py (path:/tmp/pip-fnzDSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:58:36 INFO - Running setup.py (path:/tmp/pip-yyRVts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:58:36 INFO - Running setup.py (path:/tmp/pip-jztDdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:58:36 INFO - Running setup.py (path:/tmp/pip-vCSSU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:36 INFO - Running setup.py (path:/tmp/pip-02zVkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:58:36 INFO - Running setup.py (path:/tmp/pip-T93Vmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:58:36 INFO - Running setup.py (path:/tmp/pip-ZiQ_sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:58:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:58:36 INFO - Running setup.py install for manifestparser 14:58:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:58:36 INFO - Running setup.py install for mozcrash 14:58:37 INFO - Running setup.py install for mozdebug 14:58:37 INFO - Running setup.py install for mozdevice 14:58:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:58:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:58:37 INFO - Running setup.py install for mozfile 14:58:37 INFO - Running setup.py install for mozhttpd 14:58:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:58:37 INFO - Running setup.py install for mozinfo 14:58:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:58:37 INFO - Running setup.py install for mozInstall 14:58:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:58:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:58:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:58:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:58:37 INFO - Running setup.py install for mozleak 14:58:37 INFO - Running setup.py install for mozlog 14:58:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:58:37 INFO - Running setup.py install for moznetwork 14:58:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:58:37 INFO - Running setup.py install for mozprocess 14:58:38 INFO - Running setup.py install for mozprofile 14:58:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:58:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:58:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:58:38 INFO - Running setup.py install for mozrunner 14:58:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:58:38 INFO - Running setup.py install for mozscreenshot 14:58:38 INFO - Running setup.py install for moztest 14:58:38 INFO - Running setup.py install for mozversion 14:58:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:58:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:58:38 INFO - Cleaning up... 14:58:38 INFO - Return code: 0 14:58:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:38 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 0x7f31f166ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826100>, '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 0x2827000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2827490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', '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 14:58:38 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 14:58:38 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 14:58:38 INFO - Using env: {'DISPLAY': ':0', 14:58:38 INFO - 'HOME': '/home/cltbld', 14:58:38 INFO - 'LANG': 'en_US.UTF-8', 14:58:38 INFO - 'LANGUAGE': 'en_US:en', 14:58:38 INFO - 'LOGNAME': 'cltbld', 14:58:38 INFO - 'MAIL': '/var/mail/cltbld', 14:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:38 INFO - 'MOZ_NO_REMOTE': '1', 14:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:38 INFO - 'NO_EM_RESTART': '1', 14:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:38 INFO - 'PWD': '/builds/slave/test', 14:58:38 INFO - 'SHELL': '/bin/bash', 14:58:38 INFO - 'SHLVL': '1', 14:58:38 INFO - 'TERM': 'linux', 14:58:38 INFO - 'TMOUT': '86400', 14:58:38 INFO - 'USER': 'cltbld', 14:58:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', 14:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:38 INFO - '_': '/tools/buildbot/bin/python'} 14:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:58:38 INFO - Running setup.py (path:/tmp/pip-abpgmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:58:38 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)) 14:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:58:38 INFO - Running setup.py (path:/tmp/pip-rzfN3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:58:39 INFO - Running setup.py (path:/tmp/pip-oUfRrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:58:39 INFO - Running setup.py (path:/tmp/pip-E37IQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:58:39 INFO - Running setup.py (path:/tmp/pip-1gx4pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:58:39 INFO - Running setup.py (path:/tmp/pip-eTtEjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:58:39 INFO - Running setup.py (path:/tmp/pip-NoB3iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:58:39 INFO - Running setup.py (path:/tmp/pip-fp2yPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:58:39 INFO - Running setup.py (path:/tmp/pip-AQtje5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:58:39 INFO - Running setup.py (path:/tmp/pip-9C6vqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:58:39 INFO - Running setup.py (path:/tmp/pip-lbAKvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:58:39 INFO - Running setup.py (path:/tmp/pip-3zVG16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:58:39 INFO - Running setup.py (path:/tmp/pip-yB4ola-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:58:39 INFO - Running setup.py (path:/tmp/pip-gM_lNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:39 INFO - Running setup.py (path:/tmp/pip-yadZYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:39 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)) 14:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:58:39 INFO - Running setup.py (path:/tmp/pip-Tm7Sgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:58:40 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)) 14:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:58:40 INFO - Running setup.py (path:/tmp/pip-R8So_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:58:40 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)) 14:58:40 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:58:40 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:58:40 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)) 14:58:40 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)) 14:58:40 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)) 14:58:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:41 INFO - Downloading blessings-1.6.tar.gz 14:58:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:58:41 INFO - Installing collected packages: blessings 14:58:41 INFO - Running setup.py install for blessings 14:58:42 INFO - Successfully installed blessings 14:58:42 INFO - Cleaning up... 14:58:42 INFO - Return code: 0 14:58:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:58:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:58:42 INFO - Reading from file tmpfile_stdout 14:58:42 INFO - Current package versions: 14:58:42 INFO - argparse == 1.2.1 14:58:42 INFO - blessings == 1.6 14:58:42 INFO - blobuploader == 1.2.4 14:58:42 INFO - docopt == 0.6.1 14:58:42 INFO - manifestparser == 1.1 14:58:42 INFO - mozInstall == 1.12 14:58:42 INFO - mozcrash == 0.16 14:58:42 INFO - mozdebug == 0.1 14:58:42 INFO - mozdevice == 0.48 14:58:42 INFO - mozfile == 1.2 14:58:42 INFO - mozhttpd == 0.7 14:58:42 INFO - mozinfo == 0.9 14:58:42 INFO - mozleak == 0.1 14:58:42 INFO - mozlog == 3.1 14:58:42 INFO - moznetwork == 0.27 14:58:42 INFO - mozprocess == 0.22 14:58:42 INFO - mozprofile == 0.28 14:58:42 INFO - mozrunner == 6.11 14:58:42 INFO - mozscreenshot == 0.1 14:58:42 INFO - mozsystemmonitor == 0.0 14:58:42 INFO - moztest == 0.7 14:58:42 INFO - mozversion == 1.4 14:58:42 INFO - psutil == 3.1.1 14:58:42 INFO - requests == 1.2.3 14:58:42 INFO - wsgiref == 0.1.2 14:58:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:42 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 0x7f31f166ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826100>, '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 0x2827000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2827490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', '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 14:58:42 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 14:58:42 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 14:58:42 INFO - Using env: {'DISPLAY': ':0', 14:58:42 INFO - 'HOME': '/home/cltbld', 14:58:42 INFO - 'LANG': 'en_US.UTF-8', 14:58:42 INFO - 'LANGUAGE': 'en_US:en', 14:58:42 INFO - 'LOGNAME': 'cltbld', 14:58:42 INFO - 'MAIL': '/var/mail/cltbld', 14:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:42 INFO - 'MOZ_NO_REMOTE': '1', 14:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:42 INFO - 'NO_EM_RESTART': '1', 14:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:42 INFO - 'PWD': '/builds/slave/test', 14:58:42 INFO - 'SHELL': '/bin/bash', 14:58:42 INFO - 'SHLVL': '1', 14:58:42 INFO - 'TERM': 'linux', 14:58:42 INFO - 'TMOUT': '86400', 14:58:42 INFO - 'USER': 'cltbld', 14:58:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', 14:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:42 INFO - '_': '/tools/buildbot/bin/python'} 14:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:42 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)) 14:58:42 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)) 14:58:42 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)) 14:58:42 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)) 14:58:42 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)) 14:58:42 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)) 14:58:42 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)) 14:58:42 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)) 14:58:42 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)) 14:58:42 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)) 14:58:42 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)) 14:58:42 INFO - Cleaning up... 14:58:42 INFO - Return code: 0 14:58:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:42 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 0x7f31f166ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826100>, '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 0x2827000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2827490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', '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 14:58:42 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 14:58:42 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 14:58:42 INFO - Using env: {'DISPLAY': ':0', 14:58:42 INFO - 'HOME': '/home/cltbld', 14:58:42 INFO - 'LANG': 'en_US.UTF-8', 14:58:42 INFO - 'LANGUAGE': 'en_US:en', 14:58:42 INFO - 'LOGNAME': 'cltbld', 14:58:42 INFO - 'MAIL': '/var/mail/cltbld', 14:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:42 INFO - 'MOZ_NO_REMOTE': '1', 14:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:42 INFO - 'NO_EM_RESTART': '1', 14:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:42 INFO - 'PWD': '/builds/slave/test', 14:58:42 INFO - 'SHELL': '/bin/bash', 14:58:42 INFO - 'SHLVL': '1', 14:58:42 INFO - 'TERM': 'linux', 14:58:42 INFO - 'TMOUT': '86400', 14:58:42 INFO - 'USER': 'cltbld', 14:58:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', 14:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:42 INFO - '_': '/tools/buildbot/bin/python'} 14:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:42 INFO - Downloading/unpacking jsonschema 14:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:58:44 INFO - Downloading/unpacking functools32 (from jsonschema) 14:58:44 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 14:58:44 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 14:58:44 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 14:58:44 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 14:58:44 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 14:58:44 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 14:58:44 INFO - Downloading functools32-3.2.3-2.tar.gz 14:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:58:44 INFO - warning: no files found matching '*.txt' 14:58:44 INFO - no previously-included directories found matching 'build' 14:58:44 INFO - no previously-included directories found matching 'dist' 14:58:44 INFO - no previously-included directories found matching '.git*' 14:58:44 INFO - Installing collected packages: jsonschema, functools32 14:58:44 INFO - Running setup.py install for functools32 14:58:45 INFO - warning: no files found matching '*.txt' 14:58:45 INFO - no previously-included directories found matching 'build' 14:58:45 INFO - no previously-included directories found matching 'dist' 14:58:45 INFO - no previously-included directories found matching '.git*' 14:58:45 INFO - Successfully installed jsonschema functools32 14:58:45 INFO - Cleaning up... 14:58:45 INFO - Return code: 0 14:58:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31f166ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826100>, '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 0x2827000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2827490>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', '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 14:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:58:45 INFO - Using env: {'DISPLAY': ':0', 14:58:45 INFO - 'HOME': '/home/cltbld', 14:58:45 INFO - 'LANG': 'en_US.UTF-8', 14:58:45 INFO - 'LANGUAGE': 'en_US:en', 14:58:45 INFO - 'LOGNAME': 'cltbld', 14:58:45 INFO - 'MAIL': '/var/mail/cltbld', 14:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:45 INFO - 'MOZ_NO_REMOTE': '1', 14:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:45 INFO - 'NO_EM_RESTART': '1', 14:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:45 INFO - 'PWD': '/builds/slave/test', 14:58:45 INFO - 'SHELL': '/bin/bash', 14:58:45 INFO - 'SHLVL': '1', 14:58:45 INFO - 'TERM': 'linux', 14:58:45 INFO - 'TMOUT': '86400', 14:58:45 INFO - 'USER': 'cltbld', 14:58:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', 14:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:45 INFO - '_': '/tools/buildbot/bin/python'} 14:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:45 INFO - Downloading/unpacking flake8 14:58:45 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 14:58:45 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 14:58:45 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 14:58:45 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 14:58:45 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 14:58:45 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 14:58:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:58:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:58:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:58:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:58:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:58:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:58:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:58:47 INFO - no previously-included directories found matching 'docs/_build' 14:58:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:58:47 INFO - Running setup.py install for pep8 14:58:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:58:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:58:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:58:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:58:47 INFO - no previously-included directories found matching 'docs/_build' 14:58:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:58:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:58:47 INFO - Cleaning up... 14:58:48 INFO - Return code: 0 14:58:48 INFO - Running post-action listener: _resource_record_post_action 14:58:48 INFO - Running post-action listener: _start_resource_monitoring 14:58:48 INFO - Starting resource monitoring. 14:58:48 INFO - ##### 14:58:48 INFO - ##### Running install step. 14:58:48 INFO - ##### 14:58:48 INFO - Running pre-action listener: _resource_record_pre_action 14:58:48 INFO - Running main action method: install 14:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:58:48 INFO - Reading from file tmpfile_stdout 14:58:48 INFO - Detecting whether we're running mozinstall >=1.0... 14:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:58:48 INFO - Reading from file tmpfile_stdout 14:58:48 INFO - Output received: 14:58:48 INFO - Usage: mozinstall [options] installer 14:58:48 INFO - Options: 14:58:48 INFO - -h, --help show this help message and exit 14:58:48 INFO - -d DEST, --destination=DEST 14:58:48 INFO - Directory to install application into. [default: 14:58:48 INFO - "/builds/slave/test"] 14:58:48 INFO - --app=APP Application being installed. [default: firefox] 14:58:48 INFO - mkdir: /builds/slave/test/build/application 14:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:59:04 INFO - Reading from file tmpfile_stdout 14:59:04 INFO - Output received: 14:59:04 INFO - /builds/slave/test/build/application/firefox/firefox 14:59:04 INFO - Running post-action listener: _resource_record_post_action 14:59:04 INFO - ##### 14:59:04 INFO - ##### Running run-tests step. 14:59:04 INFO - ##### 14:59:04 INFO - Running pre-action listener: _resource_record_pre_action 14:59:04 INFO - Running main action method: run_tests 14:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:59:04 INFO - Python 2.7.3 14:59:04 INFO - Return code: 0 14:59:04 INFO - grabbing minidump binary from tooltool 14:59:04 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')]} 14:59:04 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 0x2826100>, '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 0x2827000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2827490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:59:04 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 14:59:04 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 14:59:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:59:04 INFO - Return code: 0 14:59:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:59:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:59:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:59:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:59:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:59:05 INFO - Return code: 0 14:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 14:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 14:59:05 INFO - Using env: {'DISPLAY': ':0', 14:59:05 INFO - 'HOME': '/home/cltbld', 14:59:05 INFO - 'LANG': 'en_US.UTF-8', 14:59:05 INFO - 'LANGUAGE': 'en_US:en', 14:59:05 INFO - 'LOGNAME': 'cltbld', 14:59:05 INFO - 'MAIL': '/var/mail/cltbld', 14:59:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:59:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:05 INFO - 'MOZ_NO_REMOTE': '1', 14:59:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:05 INFO - 'NO_EM_RESTART': '1', 14:59:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:05 INFO - 'PWD': '/builds/slave/test', 14:59:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:59:05 INFO - 'SHELL': '/bin/bash', 14:59:05 INFO - 'SHLVL': '1', 14:59:05 INFO - 'TERM': 'linux', 14:59:05 INFO - 'TMOUT': '86400', 14:59:05 INFO - 'USER': 'cltbld', 14:59:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151', 14:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:05 INFO - '_': '/tools/buildbot/bin/python'} 14:59:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 14:59:05 INFO - mozversion application_buildid: 20160226132930 14:59:05 INFO - mozversion application_changeset: 139446b09ca7f9dd05ad11ca8db9103b90aa69b2 14:59:05 INFO - mozversion application_display_name: Nightly 14:59:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:59:05 INFO - mozversion application_name: Firefox 14:59:05 INFO - mozversion application_remotingname: firefox 14:59:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:59:05 INFO - mozversion application_vendor: Mozilla 14:59:05 INFO - mozversion application_version: 47.0a1 14:59:05 INFO - mozversion platform_buildid: 20160226132930 14:59:05 INFO - mozversion platform_changeset: 139446b09ca7f9dd05ad11ca8db9103b90aa69b2 14:59:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:59:05 INFO - mozversion platform_version: 47.0a1 14:59:05 INFO - using testdate: 1456527545 14:59:05 INFO - actual date: 1456527545 14:59:05 INFO - starting webserver on 'localhost:34811' 14:59:05 INFO - SUITE-START | Running 2 tests 14:59:05 INFO - TEST-START | dromaeo_css 14:59:05 INFO - operating with platform_type : linux_ 14:59:05 INFO - Initialising browser for dromaeo_css test... 14:59:05 INFO - TEST-INFO | started process 5247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDCnLEh/profile http://localhost:34811/getInfo.html) 14:59:09 INFO - PROCESS | 5247 | 14:59:09 INFO - PROCESS | 5247 | (process:5328): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:59:10 INFO - PROCESS | 5247 | __metrics Screen width/height:1600/1200 14:59:10 INFO - PROCESS | 5247 | colorDepth:24 14:59:10 INFO - PROCESS | 5247 | Browser inner width/height: 1024/697 14:59:10 INFO - PROCESS | 5247 | __metrics 14:59:11 ERROR - PROCESS | 5247 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:59:11 INFO - PROCESS | 5247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:59:11 INFO - PROCESS | 5247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:59:11 INFO - PROCESS | 5247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:59:11 INFO - PROCESS | 5247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:59:11 INFO - PROCESS | 5247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:59:11 INFO - PROCESS | 5247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:59:11 INFO - PROCESS | 5247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:59:11 INFO - PROCESS | 5247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:59:11 INFO - PROCESS | 5247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:59:12 INFO - TEST-INFO | 5247: exit 0 14:59:12 INFO - Browser initialized. 14:59:12 INFO - Running cycle 1/1 for dromaeo_css test... 14:59:12 INFO - TEST-INFO | started process 5379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDCnLEh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:13 INFO - PROCESS | 5379 | 14:59:13 INFO - PROCESS | 5379 | (process:5434): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:59:24 INFO - PROCESS | 5379 | RSS: Main: 157982720 14:59:24 INFO - PROCESS | 5379 | 15:00:13 INFO - PROCESS | 5379 | 1456527613837 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] 15:02:25 INFO - PROCESS | 5379 | Cycle 1(1): loaded http://localhost:34811/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34811/tests/dromaeo/cssquery-ext.html) 15:02:26 INFO - PROCESS | 5379 | RSS: Main: 166785024 15:02:26 INFO - PROCESS | 5379 | 15:05:28 INFO - PROCESS | 5379 | Cycle 1(1): loaded http://localhost:34811/tests/dromaeo/cssquery-ext.html (next: http://localhost:34811/tests/dromaeo/cssquery-jquery.html) 15:05:28 INFO - PROCESS | 5379 | RSS: Main: 163565568 15:05:28 INFO - PROCESS | 5379 | 15:08:30 INFO - PROCESS | 5379 | Cycle 1(1): loaded http://localhost:34811/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34811/tests/dromaeo/cssquery-mootools.html) 15:08:30 INFO - PROCESS | 5379 | RSS: Main: 163217408 15:08:30 INFO - PROCESS | 5379 | 15:11:32 INFO - PROCESS | 5379 | Cycle 1(1): loaded http://localhost:34811/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34811/tests/dromaeo/cssquery-prototype.html) 15:11:33 INFO - PROCESS | 5379 | RSS: Main: 160456704 15:11:33 INFO - PROCESS | 5379 | 15:14:35 INFO - PROCESS | 5379 | Cycle 1(1): loaded http://localhost:34811/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34811/tests/dromaeo/cssquery-yui.html) 15:14:36 INFO - PROCESS | 5379 | RSS: Main: 161226752 15:14:36 INFO - PROCESS | 5379 | 15:17:38 INFO - PROCESS | 5379 | Cycle 1(1): loaded http://localhost:34811/tests/dromaeo/cssquery-yui.html (next: http://localhost:34811/tests/dromaeo/cssquery-dojo.html) 15:17:39 INFO - PROCESS | 5379 | RSS: Main: 165801984 15:17:39 INFO - PROCESS | 5379 | 15:17:39 INFO - PROCESS | 5379 | __start_tp_report 15:17:39 INFO - PROCESS | 5379 | _x_x_mozilla_page_load 15:17:39 INFO - PROCESS | 5379 | _x_x_mozilla_page_load_details 15:17:39 INFO - PROCESS | 5379 | |i|pagename|runs| 15:17:39 INFO - PROCESS | 5379 | |0;dojo.html;2630.237231202951;2647.8940842366305;2670.7596316331537;2674.9999999999995;2681.9597706034415;4419.49175844778;4545.954540454594;4559.817607295704;4569.634429245661;4595.88510287243;4521.638268938485;4585.839495617654;4586.587207151364;4592.288195329721;4637.768111594423;4225.978870105645;4227.217964676537;4234.1955028544635;4285.72849427608;4322.13557288542;4173.1862286854075;4226;4270.551592082833;4271.850485233017;4278.700490965633;4207.347861081537;4211.915761684749;4218.388333691598;4244.469441319835;4246.851360202378;4215.156968606291;4215.852445164435;4250.0437401584395;4252.659787217046;4270.316749320094;4103.4870641169855;4135.8966025849295;4211.957880421218;4225.577442255781;4239.957600423987;4397.31841564558;4407.955920440819;4417.425734654475;4421.845235416745;4452.265376212921;4761.8095276188915;4765;4795.2807078938085;4798.976005119987;4848.5636292733825;4747.145513807513;4809.110314591777;4859.757012149414;4888.486708895586;4947.777350019222;4479.910401791946;4489.483709373399;4491.562699935989;4509.4814096379005;4520.615747661485;4939.086269040239;4945.159322915113;4951.603871690256;4954.8761280968265;4988;4639.420072490939;4781.976090119527;4814.807407703723;4846.200376937836;4869.391326084239;4728.101660684459;4846.733429661403;4856.781444834991;4881.95118048822;4926.926096108561;4785.186518291899;4786.401699787527;4787.138315103315;4800.039992001543;4831.637627177905;4693.084848454519;4801.95198048015;4808.230683090758;4831.130396528588;4868.075065737569;4112.465379500705;4128.442660240889;4129.545749967501;4156.709030367845;4165.437665915063;3516.331896939573;3636.5454318210222;3636.890893273206;3651.6165802590344;3671.853125874935;4192.664586833046;4233.936490952638;4241.575842415734;4247.447831781848;4273.893152671208;4809.230523116355;4851.708897466164;4852.199387101159;4872.293517439952;4901.166801643729;4156.25187466259;4182.81177347014;4192.937105943413;4211.389348544505;4223.239816832999;4320.4383430153875;4324.308110702273;4327.480702315679;4356.934645980313;4367.47590289161;4507.8196872124745;4568.0407114505;4569.13186494565;4582.702124361973;4608.470025946992;4841.443234028132;4914.5085491452;4983.551480366785;5016.172331565251;5032.874178145576;4621.6302695784925;4660.790264438041;4680.953190468052;4680.976595117003;4725.905481890274;4658.208104622155;4870.610351171827;4876.073546026244;4878.390201224847;4915.090708218991;4846.660733748604;4848.418189817245;4874.707517548958;4902.534259245366;4917.26241063829;4559.338895860015;4645.09420662981;4696.506866778939;4701.717896926195;4747.905041899212;4570.223062079521;4677.087967846237;4696.38946936896;4697.177993851131;4731.337612734289;4499.077689073667;4512.9548704513845;4540.978279886999;4543.6365090792;4594.540545945512;4743.264793956942;4744.4069491313585;4746.288056791371;4772.427308722976;4776.8566942991765;4612.469565999953;4657.0918670858855;4668.996165824228;4671.906561868812;4706.576408123286 15:17:39 INFO - PROCESS | 5379 | |1;ext.html;470.5271202441548;512.203523520925;528.6722232216024;540.5972550449916;547.4689551135398;32411.189720256974;33043.834780826124;33082.338353232924;33119.503207451875;33151.502727459076;29367.412651746952;29784.25539361517;29830.55254171189;29868.701312986865;29941.401171976548;7336.743213987498;7485.288897554751;7487.887681684779;7490.063742032246;7497.700091996314;7498.850022999537;7780;7801.882971755428;7822.530648161129;7858.096318923312;7746.341560967297;7842.803929901769;7883.526988380687;7886.250806173404;7887.290143887049;7797;7812.960935195344;7832.530048197098;7852.21477852216;7852.842943141134;7605.695772169107;7785.649645765954;7803.843923121506;7817.101033381177;7837.529748215125;34203;34374.312513749835;34452.48321275183;34707.30585388303;34761;2586.2887705880844;2723.4280801031805;2833.6316278883614;2867.311845157147;3398.5411969384313;28038;28655.14034578966;28713.85643071771;29526.409471810442;29752.40495190084;2791.9581206281923;3438.9312213755834;3451.706604938583;3572.8928132156075;3606.206634540397;209117;209228;209726;210066;211894;42257;55267;55677.44322556723;55741.442585573626;55746.72126639341;41036;41043.179136417704;41228.79385603053;41238.79380603078;41359.1728165441;12995.675108122372;13123.803142952864;13251.801222981663;13287.601371958857;13355.933220334031;9795.657151999645;9810.607575697035;9842.50787460624;9904.059114384121;9913.206943444507;13601.183928964294;13610.931945340408;13642.795358069638;13792.172469651852;13799.86200138006;5466.262054622654;5532.1425179097305;5595.440455954454;5600.27196464457;5610.653443173691;881.9118088191129;957.5834511987308;990.2177279948904;1003.8556046107443;1052.0899422000068;26172.73827261703;26297.34256643561;26345.604815927778;26364.736352636228;26485.205443836716;943.033390774448;977.452626529146;1000.7848312612823;1001.9198464122853;1029.351508549609;13656.248906310248;13757.931210343884;13910.86089139116;14107.083039602392;14123.71752564943;257717;259009;259926;260903;261871;38491.61508384936;38627.61372386297;38637.80681096633;38996;39137.41293880594;1197.581239860377;1211.436681942883;1228.827964085011;1231.347385885482;1234.8950339221267;25127;25940.481190376464;26266.868665656548;26302;26759.331016724736;40775.38836917508;40952.79523602363;41070.79464602658;41151.58848411478;41274.58725412707;242226;242489;242949;243775;244216;29727.70272297249;29869.253268668457;30577.23556911095;30693.23266918345;30733.846330768203;39485;39526.802365987984;39596.604033960444;39858.402123967586;40042.1991560173;33298.33403331968;33886.491702624975;34174.316513670085;34241.486377703855;34270.14324641904;33622.327553448304;33927.830360849024;34160.31679366448;34335.484967725;34394.65605344014;34660.65339346574;35111.297774044884;35658.28683426265;36540.63459365479;36592.26815463729;27365;30227.395452090394;30977.845110774302;31051.844740776152;31109.377812444076;23546.52906941886;23767.286981390585;23806.642900356856;23889.163879264142;24086.759132408453 15:17:39 INFO - PROCESS | 5379 | |2;jquery.html;332.9711192415436;334.9866005359785;339.3230505142242;343.54651859545396;345.9117924929143;14423.278836058207;14944.77582836257;15508.069515829058;15686.843131568681;15785.13181775002;14098.788518172236;14153.363098660559;14454.566363009126;14502;14630.122192668447;4884.096442158203;5118;5118.718470484122;5119.257707632391;5126.5642420394315;4656.767161641921;5002.924956125661;5088.465711100337;5096.79612815487;5113.642045056848;5036.219385995177;5041.218611115265;5069.062223488648;5071.847844564669;5073.086844368012;4827.686200396963;4991.450940396553;4999.500049994989;5028.622853286018;5052.9242061369105;4479.932801007955;4494.9325760113625;4496.3705081288645;4497.8425755098415;4505.166544189303;18144.727829082574;18413.07934603278;18590.44228673142;18627.90686046561;18633.254669813192;1873.0447471789485;1929.0644037641732;1945.105251584273;1948.4252145616936;2253.5605556916407;11864.881351186465;12009.039276857831;12088.758224835541;12244.326562039085;12550.623481295575;1764.5676809181705;1781.910904454772;1793.4798908316573;1808.5569035586366;1819.4996375996575;53106.46893531054;53714.46285537173;54158;54193;54434.18348724733;9082.364234503653;9115.134062264075;9444.244460443148;9459.716208513755;9553.570089345996;11963.222390544586;11974.042076633848;12001.819972700416;12023.819642705366;12081.697957551132;6788.321167883172;6852.074969879102;7016.158061032709;7112.786616401516;7112.964435177791;6683.465322774166;6727.461803055744;6818.590884546943;6819.215790184192;6823.454123670094;5540.335159780852;5655.462731040545;5702.600817942787;5721.141828725641;5757.85605359861;1688.6200604863807;1721.5265801904577;1726.3612463388627;1734.9219285132199;1740.4082611911758;912.056022017209;929.4051806843626;937.4234845570062;938.3244064273712;984.0897170117613;15145.772813407808;15266.847331526764;15296.005759625588;15492.07047577149;15718.842811571738;863.926566241864;894.2354287084579;934.514052692596;939.234523863063;970.2238209432426;8990.021541585138;9089;9140.771480713036;9239.937407198124;9304.627814887464;346037;358159;361333;363666;373940;42220.73337799871;48409.27386089211;50230.24654630184;57835.42164578385;58647.120293195636;924.7503174142944;930.9860352094724;951.7763325618474;953.3660116022767;956.660385563115;13756.793648095087;14034.508792192633;14048.438062477795;14359.856401435853;14468.565943021726;28164.43671126607;29197.270068247613;29485.26286842846;30414.087577372713;30590.08229753111;34863.12842178966;36451;37678.05804854791;37725.245495089395;37765.4335184967;6578.342165783383;6752.189737231563;6820.965895170492;6821.420179284618;6868.381845633917;9036.45781253127;10762.51568679427;10812.729681757704;10978.560857565928;10985.945070274916;9320.860187097334;9469.66856160031;9559.23526117895;9752.756181095529;9754.170895473964;9294.488803115893;9314.6274149036;9332.253419726541;9368.110029547182;9754.414735115915;10052.597896084368;10217.846732299171;10256.53845576936;10328.845067324146;10563.63027294041;6619.205695316593;6687.398134167948;6711.161104861892;6835.111435513351;6920.100386949664;9234.076592340713;9456.669016584387;9571.138597526256;9666;9672.322937394314 15:17:39 INFO - PROCESS | 5379 | |3;mootools.html;1257.2582176515857;1340.530814215025;1420.9130015538115;1681.9495415137542;1684.6125391160026;5543.667379957195;6516.0877477153235;6579.407853293203;6737.595744255348;6756.797296081119;6662.7668031618905;6696.765613203539;6699.4975376846805;6736.629485378302;6768.830779230521;2018.2633338831295;2033.5119571302928;2034.0948278016251;2060.206820374152;2060.4230815371643;1963.3520938090396;1997.2410484016054;1997.7702564205158;2028.9855072463768;2029.1781828359465;1984.8809071455687;1995.950101247466;1997.6304383689064;2003.4089943466713;2010.2059686423854;2035.0740413112073;2046.8669536480156;2047.2322878920404;2049.846261530384;2050.3643870400224;1990.6217818614416;2009.9598008039757;2024.4938765308673;2029.512916899948;2030.8984550772402;6777.423918966893;6873.931260687379;6891.207511136183;6899.413549848218;6906.06768086307;4042.757434553936;4140.420341152241;4150.481189851269;4153.813078411479;4158.854440094582;2559.923202303934;2628.5531459651907;2639.4457163995585;2657.50836095323;2704.756571908538;796.7410591557767;803.7869964459423;803.8995125609299;813.2639960835394;819.635262308273;9030.593623286968;9056.184943355129;9118.77203069922;9128.771780705469;9147.81704365909;3717.368047431943;3768.9811550942068;3835.76985380878;3836.07934095815;3842.538895332578;7567.091948966159;7567.735129270559;7578.09062912454;7602.353799927068;7647.388208943271;4137.069159439162;4144.461220041375;4170.395292682544;4185.24665560196;4199.643030342455;3099.5660607514965;3761.1725420407465;3780.8298626561873;3798.6771124454176;3828.7511311764647;3282.7373810095137;3300.8184549849507;3360.798352098882;3387.4072037393357;3390.6439823818637;1077.4666540062562;1078.6278733836814;1080.3140006096185;1081.4214395298477;1091.7772095253208;874.8687696845524;884.0319849764497;884.4958373726914;900.446225571269;965.7875267441152;6099.085137229363;6143.6928153593035;6185.319614842364;6192.907106393408;6200.906986395207;1001.1440218613127;1026.097034609539;1045.534737042009;1045.7699306152633;1052.7947050325113;4988.9501104988485;5042.621803364762;5084.8220312288895;5087.796488140507;5103.744812759347;7722.806929826799;7977.282044616012;8013.11855695873;8171.264586187272;8295.585220738938;8094.51432914027;8116.6347514362;8122.796930076677;8166.142555031755;8180.877286840702;6411.67941602918;6485.254195767453;6513.2184137902805;6530;6531.183602049744;5979.641221526722;6133.8466538335115;6138.508919286357;6155.599886007395;6167.290761562478;7212.71149154028;7226.963865180641;7314.268573142856;7320.194778574246;7396.55620662762;7343.48595598303;7473.738419155304;7510.774676759706;7546.584937828472;7567.848643027219;4753.548412900769;5381.811636592701;5640.943590564042;5695.772169113189;5714.3714191438075;6296.653684047238;6308.549033722178;6325.620462772248;6337.207849018872;6350.301466838551;5710.086386178192;5755.65466072037;5811.970940145272;5896.911546326723;5970.283565972111;5539.279893613804;5670.319561652628;5745.827625171251;5752.827415177551;5755.482006619424;5902.498287645598;6058.3335833057445;6061.7575296987625;6094.603850749864;6240.251169859464;5596.272484576979;5661.264035675335;5662.065759149694;5675;5676.687782171855;5862.237909071793;5912.822615321547;5913.970430147821;5914.467697907209;5924.377940316204 15:17:39 INFO - PROCESS | 5379 | |4;prototype.html;290.43365437397074;296.2445763303575;299.94001199760055;301.9698030196982;305.3922693839259;5460.208269800876;5520.641158324706;5551.72241387931;5589.580781441387;5693.487586117249;5531.170324451325;5566.693831839248;5593.077142271521;5601.915971260434;5605.831825045245;4048.67610591152;4153.190127925056;4176.812043458051;4235.57644235577;4248.660107191417;4203.831846726127;4205.600467955539;4208.558101399355;4211.747295162285;4232.619064284214;4165.958340416587;4176.1230141670285;4176.143890502455;4188.874333769992;4189.790510474464;4127.339625659895;4179.26862799009;4188.560201178862;4189.28782107041;4197;3611.855525778992;3622.3841946868833;3624.4382120771324;3627.0207044097947;3627.038834708804;5329.387120481156;5339.893202135974;5342.599305052097;5346.41189469162;5351.117065684196;4510.233260345716;4800.159972004885;4808.2547205183255;4813.08551375241;4816.397950256218;5757.136429535562;5770.336411312669;5787.33445653751;5805.88388232233;5817.7382017809305;3756.793376364299;3758.868439604628;3766.2090960898245;3771.283456143324;3774.3772277574167;6036.577439579231;6117.5717699761035;6123.142760013601;6127.44852963231;6127.877442451126;3893.0851249956236;3896.4350169225304;3914.432407300925;3915.8237879295502;3916.4712763777097;3960.544537378181;3964.365701487748;3965.40518922164;3965.7620542767527;3965.9688480994573;4608.147492713859;4657.604103651228;4662.487126416091;4681;4697.530246975343;5771.105478650816;5798.072308430631;5803.47768700819;5820.912686309709;5822.1266809978;1422.3599380278708;1438.841727409984;1444.6677264229286;1446.146773403697;1448.0732331307972;899.7930475990559;940.3464592108419;942.820864035831;958.712386284112;969.1471505075489;5065.873353166126;5069.670471419346;5072.442031376546;5072.67027643202;5075.289459475676;6053.092036194606;6058;6059.27288725347;6064.06007068905;6064.545159113084;5045.672031317952;5049;5051.570616497565;5054.848354549369;5056.089903817275;3180.6183258008723;3268.67313268676;3275.4922986937063;3276.5904261967253;3277.082416923265;5722.341930677942;5758.395368486333;5758.856028599319;5765.279340082489;5787.102999035156;6277.497800175975;6280.811575652738;6291.842703932438;6316.399942005502;6316.842078948063;5747.885042299131;5748.338941021752;5750.3099628044065;5762.193292938992;5773.971130144322;5827.94172058274;5917.082852157922;6058.787942421994;6090.878182436238;6102.420270074336;5822.505087067647;5981.491573216325;5985.221921150397;5986.3115741688525;6004.129401236709;5684.71576421169;5753.453421924911;5786;5791;5793.652380857162;4149;4162.188373267305;4163.583641635933;4191.622753952159;4194.496660400771;5979.431953964367;5979.671118088547;6000.129981152796;6041.758329666764;6057.848553786191;5664.886702266014;5748.741306641127;5933.495652869382;5935.0207215808905;5938.465538101592;5854.853628659318;5863.442972917566;5865.090910908816;5928.466438020599;5952.0476723724;5728.283964504437;5738.426157384228;5741.5406767459335;5744.109663002241;5751.051076572486;5873.471387575139;5909.23179986599;5914.792982245601;5916.142159386951;5919.792807251725;5580.832575022756;5755.913661295168;5778.248827652378;5787.508061814793;5789.913151302818 15:17:39 INFO - PROCESS | 5379 | |5;yui.html;504.7249249159208;585.180746954264;642.9485641148708;648.8053583924822;649.8895187818074;10745.247832651708;11018.834717479243;11063.612773552928;11065.834012489799;11082.556697732081;10302.175825933908;11457.885421145786;11471.139664525152;11488.36813975231;11488.425578721073;768.2202564397141;778.781941056505;788.7988562916477;799.8840168175611;800.951942883426;784.9568273744942;789.3093543149744;789.8617741895174;792.528445574882;795.6976348987406;523.6988731479396;526.1240035341172;526.6208330002411;532.9706866122361;536.1020291012538;514.4957941217609;519.4779246856884;520.3131865936965;523.2543625333922;523.9764210610513;376.23999520967766;377.06487909983395;379.02779370913794;379.2358397828378;381.7823840410967;11378.886211137866;11416.42917854104;11459.656210313704;11473.311601303949;11962.700932476671;11236.550537978472;11297.435128243555;11436.027937625311;11535.365554894477;11681.591144309994;9011.504367259799;9029.322800789902;9062.954685226532;9173.403728757676;9254.86117708235;2730.931726706828;2937.1922721251826;2948.3366242595457;2948.9852550737323;2956.659984101813;37966.43050354247;39150.2169956605;40387.59612403897;41272.79363603193;41275.380869286986;8827.867581986275;8843.60203790831;8857.11428857122;8861.955690221508;8939.553022348857;15447.845521544641;15569.143697096768;15600.92199538995;15604.141772202638;15618.843811561967;5647.096464565732;5677.971610141923;5757.481826635623;5773.942260577424;5778.219940308089;3048.314129320885;3090.3973725123833;3117.3921085388583;3118.6413562440157;3242.789218700777;2427.235420842429;2517.5090857282653;2528.797696184301;2533.0880882882147;2543.122622695167;464.63758268550583;465.14645625277996;466.7269647256325;470.3556128104519;471.94049359188153;472.7919715325246;493.3339991012105;522.454035532869;522.5636593444441;534.7272890825707;7090;7198.640067996579;7320;7430.038127040252;7531.962340188264;428.71062033127515;506.2709698034818;520.6199474383722;530.933633295838;532.1698150884632;3414.197663549064;3456.89109197267;3457.619661837196;3543.167355671415;3588.4796704477703;46631.766841165576;47499.525004750205;47611;47842.5215747845;47858;42390.78804605957;42852;43229.783851080545;43322.35016474756;44015.11969760651;39115;39210;39522.80238598789;39659.60340396617;39714.2057158861;6788;6840.863182736417;6926.826829329307;7030;7121.893171602326;29037.7096229035;30462.390752185274;30766;31244.531332030492;31442.21394465157;35479.467807982386;35750.4637430444;35982.8200858994;38165.04587385338;38548.6145138545;7716.884246736416;7919.881201782093;8109.026916770025;8173.5504547250475;8264.876026859722;8852.867206991772;8951.507667078373;8953.776155596162;9058.728238152866;9218.539073046455;8670.956645216733;8821.691240806542;8836.160564746338;8836.690715825172;8942.86585701202;8218.794530136794;8381.874271885805;8554.91445085566;8585.399022068645;8699.739007829776;8181.227833558262;8386.329093672613;8571.22858942698;8583.197434359587;8677.609507572048;7592.8861067085145;7626.389888808771;7647.655855486405;7677.424193185645;7775.22247775218;7653.158152603098;7677.9232207677205;7723.189065148304;7992.600369981594;8036.357091432555 15:17:39 INFO - PROCESS | 5379 | __end_tp_report 15:17:39 INFO - PROCESS | 5379 | __start_cc_report 15:17:39 INFO - PROCESS | 5379 | _x_x_mozilla_cycle_collect,339 15:17:39 INFO - PROCESS | 5379 | __end_cc_report 15:17:39 INFO - PROCESS | 5379 | __startTimestamp1456528659003__endTimestamp 15:17:39 INFO - PROCESS | 5379 | 15:17:39 INFO - PROCESS | 5379 | ------- Summary: start ------- 15:17:39 INFO - PROCESS | 5379 | Number of tests: 6 15:17:39 INFO - PROCESS | 5379 | 15:17:39 INFO - PROCESS | 5379 | [#0] dojo.html Cycles:165 Average:4493.95 Median:4592.29 stddev:445.19 (9.7%) stddev-sans-first:421.86 15:17:39 INFO - PROCESS | 5379 | Values: 2630.2 2647.9 2670.8 2675.0 2682.0 4419.5 4546.0 4559.8 4569.6 4595.9 4521.6 4585.8 4586.6 4592.3 4637.8 4226.0 4227.2 4234.2 4285.7 4322.1 4173.2 4226.0 4270.6 4271.9 4278.7 4207.3 4211.9 4218.4 4244.5 4246.9 4215.2 4215.9 4250.0 4252.7 4270.3 4103.5 4135.9 4212.0 4225.6 4240.0 4397.3 4408.0 4417.4 4421.8 4452.3 4761.8 4765.0 4795.3 4799.0 4848.6 4747.1 4809.1 4859.8 4888.5 4947.8 4479.9 4489.5 4491.6 4509.5 4520.6 4939.1 4945.2 4951.6 4954.9 4988.0 4639.4 4782.0 4814.8 4846.2 4869.4 4728.1 4846.7 4856.8 4882.0 4926.9 4785.2 4786.4 4787.1 4800.0 4831.6 4693.1 4802.0 4808.2 4831.1 4868.1 4112.5 4128.4 4129.5 4156.7 4165.4 3516.3 3636.5 3636.9 3651.6 3671.9 4192.7 4233.9 4241.6 4247.4 4273.9 4809.2 4851.7 4852.2 4872.3 4901.2 4156.3 4182.8 4192.9 4211.4 4223.2 4320.4 4324.3 4327.5 4356.9 4367.5 4507.8 4568.0 4569.1 4582.7 4608.5 4841.4 4914.5 4983.6 5016.2 5032.9 4621.6 4660.8 4681.0 4681.0 4725.9 4658.2 4870.6 4876.1 4878.4 4915.1 4846.7 4848.4 4874.7 4902.5 4917.3 4559.3 4645.1 4696.5 4701.7 4747.9 4570.2 4677.1 4696.4 4697.2 4731.3 4499.1 4513.0 4541.0 4543.6 4594.5 4743.3 4744.4 4746.3 4772.4 4776.9 4612.5 4657.1 4669.0 4671.9 4706.6 15:17:39 INFO - PROCESS | 5379 | 15:17:39 INFO - PROCESS | 5379 | [#1] ext.html Cycles:180 Average:38837.14 Median:34167.32 stddev:62113.93 (181.8%) stddev-sans-first:62221.37 15:17:39 INFO - PROCESS | 5379 | Values: 470.5 512.2 528.7 540.6 547.5 32411.2 33043.8 33082.3 33119.5 33151.5 29367.4 29784.3 29830.6 29868.7 29941.4 7336.7 7485.3 7487.9 7490.1 7497.7 7498.9 7780.0 7801.9 7822.5 7858.1 7746.3 7842.8 7883.5 7886.3 7887.3 7797.0 7813.0 7832.5 7852.2 7852.8 7605.7 7785.6 7803.8 7817.1 7837.5 34203.0 34374.3 34452.5 34707.3 34761.0 2586.3 2723.4 2833.6 2867.3 3398.5 28038.0 28655.1 28713.9 29526.4 29752.4 2792.0 3438.9 3451.7 3572.9 3606.2 209117.0 209228.0 209726.0 210066.0 211894.0 42257.0 55267.0 55677.4 55741.4 55746.7 41036.0 41043.2 41228.8 41238.8 41359.2 12995.7 13123.8 13251.8 13287.6 13355.9 9795.7 9810.6 9842.5 9904.1 9913.2 13601.2 13610.9 13642.8 13792.2 13799.9 5466.3 5532.1 5595.4 5600.3 5610.7 881.9 957.6 990.2 1003.9 1052.1 26172.7 26297.3 26345.6 26364.7 26485.2 943.0 977.5 1000.8 1001.9 1029.4 13656.2 13757.9 13910.9 14107.1 14123.7 257717.0 259009.0 259926.0 260903.0 261871.0 38491.6 38627.6 38637.8 38996.0 39137.4 1197.6 1211.4 1228.8 1231.3 1234.9 25127.0 25940.5 26266.9 26302.0 26759.3 40775.4 40952.8 41070.8 41151.6 41274.6 242226.0 242489.0 242949.0 243775.0 244216.0 29727.7 29869.3 30577.2 30693.2 30733.8 39485.0 39526.8 39596.6 39858.4 40042.2 33298.3 33886.5 34174.3 34241.5 34270.1 33622.3 33927.8 34160.3 34335.5 34394.7 34660.7 35111.3 35658.3 36540.6 36592.3 27365.0 30227.4 30977.8 31051.8 31109.4 23546.5 23767.3 23806.6 23889.2 24086.8 15:17:39 INFO - PROCESS | 5379 | 15:17:39 INFO - PROCESS | 5379 | [#2] jquery.html Cycles:180 Average:21340.69 Median:5001.21 stddev:58874.72 (1177.2%) stddev-sans-first:59018.74 15:17:39 INFO - PROCESS | 5379 | Values: 333.0 335.0 339.3 343.5 345.9 14423.3 14944.8 15508.1 15686.8 15785.1 14098.8 14153.4 14454.6 14502.0 14630.1 4884.1 5118.0 5118.7 5119.3 5126.6 4656.8 5002.9 5088.5 5096.8 5113.6 5036.2 5041.2 5069.1 5071.8 5073.1 4827.7 4991.5 4999.5 5028.6 5052.9 4479.9 4494.9 4496.4 4497.8 4505.2 18144.7 18413.1 18590.4 18627.9 18633.3 1873.0 1929.1 1945.1 1948.4 2253.6 11864.9 12009.0 12088.8 12244.3 12550.6 1764.6 1781.9 1793.5 1808.6 1819.5 53106.5 53714.5 54158.0 54193.0 54434.2 9082.4 9115.1 9444.2 9459.7 9553.6 11963.2 11974.0 12001.8 12023.8 12081.7 6788.3 6852.1 7016.2 7112.8 7113.0 6683.5 6727.5 6818.6 6819.2 6823.5 5540.3 5655.5 5702.6 5721.1 5757.9 1688.6 1721.5 1726.4 1734.9 1740.4 912.1 929.4 937.4 938.3 984.1 15145.8 15266.8 15296.0 15492.1 15718.8 863.9 894.2 934.5 939.2 970.2 8990.0 9089.0 9140.8 9239.9 9304.6 346037.0 358159.0 361333.0 363666.0 373940.0 42220.7 48409.3 50230.2 57835.4 58647.1 924.8 931.0 951.8 953.4 956.7 13756.8 14034.5 14048.4 14359.9 14468.6 28164.4 29197.3 29485.3 30414.1 30590.1 34863.1 36451.0 37678.1 37725.2 37765.4 6578.3 6752.2 6821.0 6821.4 6868.4 9036.5 10762.5 10812.7 10978.6 10985.9 9320.9 9469.7 9559.2 9752.8 9754.2 9294.5 9314.6 9332.3 9368.1 9754.4 10052.6 10217.8 10256.5 10328.8 10563.6 6619.2 6687.4 6711.2 6835.1 6920.1 9234.1 9456.7 9571.1 9666.0 9672.3 15:17:39 INFO - PROCESS | 5379 | 15:17:39 INFO - PROCESS | 5379 | [#3] mootools.html Cycles:180 Average:4709.55 Median:5754.15 stddev:2396.36 (41.6%) stddev-sans-first:2389.03 15:17:39 INFO - PROCESS | 5379 | Values: 1257.3 1340.5 1420.9 1681.9 1684.6 5543.7 6516.1 6579.4 6737.6 6756.8 6662.8 6696.8 6699.5 6736.6 6768.8 2018.3 2033.5 2034.1 2060.2 2060.4 1963.4 1997.2 1997.8 2029.0 2029.2 1984.9 1996.0 1997.6 2003.4 2010.2 2035.1 2046.9 2047.2 2049.8 2050.4 1990.6 2010.0 2024.5 2029.5 2030.9 6777.4 6873.9 6891.2 6899.4 6906.1 4042.8 4140.4 4150.5 4153.8 4158.9 2559.9 2628.6 2639.4 2657.5 2704.8 796.7 803.8 803.9 813.3 819.6 9030.6 9056.2 9118.8 9128.8 9147.8 3717.4 3769.0 3835.8 3836.1 3842.5 7567.1 7567.7 7578.1 7602.4 7647.4 4137.1 4144.5 4170.4 4185.2 4199.6 3099.6 3761.2 3780.8 3798.7 3828.8 3282.7 3300.8 3360.8 3387.4 3390.6 1077.5 1078.6 1080.3 1081.4 1091.8 874.9 884.0 884.5 900.4 965.8 6099.1 6143.7 6185.3 6192.9 6200.9 1001.1 1026.1 1045.5 1045.8 1052.8 4989.0 5042.6 5084.8 5087.8 5103.7 7722.8 7977.3 8013.1 8171.3 8295.6 8094.5 8116.6 8122.8 8166.1 8180.9 6411.7 6485.3 6513.2 6530.0 6531.2 5979.6 6133.8 6138.5 6155.6 6167.3 7212.7 7227.0 7314.3 7320.2 7396.6 7343.5 7473.7 7510.8 7546.6 7567.8 4753.5 5381.8 5640.9 5695.8 5714.4 6296.7 6308.5 6325.6 6337.2 6350.3 5710.1 5755.7 5812.0 5896.9 5970.3 5539.3 5670.3 5745.8 5752.8 5755.5 5902.5 6058.3 6061.8 6094.6 6240.3 5596.3 5661.3 5662.1 5675.0 5676.7 5862.2 5912.8 5914.0 5914.5 5924.4 15:17:39 INFO - PROCESS | 5379 | 15:17:39 INFO - PROCESS | 5379 | [#4] prototype.html Cycles:180 Average:4793.00 Median:5585.21 stddev:1458.78 (26.1%) stddev-sans-first:1423.19 15:17:39 INFO - PROCESS | 5379 | Values: 290.4 296.2 299.9 302.0 305.4 5460.2 5520.6 5551.7 5589.6 5693.5 5531.2 5566.7 5593.1 5601.9 5605.8 4048.7 4153.2 4176.8 4235.6 4248.7 4203.8 4205.6 4208.6 4211.7 4232.6 4166.0 4176.1 4176.1 4188.9 4189.8 4127.3 4179.3 4188.6 4189.3 4197.0 3611.9 3622.4 3624.4 3627.0 3627.0 5329.4 5339.9 5342.6 5346.4 5351.1 4510.2 4800.2 4808.3 4813.1 4816.4 5757.1 5770.3 5787.3 5805.9 5817.7 3756.8 3758.9 3766.2 3771.3 3774.4 6036.6 6117.6 6123.1 6127.4 6127.9 3893.1 3896.4 3914.4 3915.8 3916.5 3960.5 3964.4 3965.4 3965.8 3966.0 4608.1 4657.6 4662.5 4681.0 4697.5 5771.1 5798.1 5803.5 5820.9 5822.1 1422.4 1438.8 1444.7 1446.1 1448.1 899.8 940.3 942.8 958.7 969.1 5065.9 5069.7 5072.4 5072.7 5075.3 6053.1 6058.0 6059.3 6064.1 6064.5 5045.7 5049.0 5051.6 5054.8 5056.1 3180.6 3268.7 3275.5 3276.6 3277.1 5722.3 5758.4 5758.9 5765.3 5787.1 6277.5 6280.8 6291.8 6316.4 6316.8 5747.9 5748.3 5750.3 5762.2 5774.0 5827.9 5917.1 6058.8 6090.9 6102.4 5822.5 5981.5 5985.2 5986.3 6004.1 5684.7 5753.5 5786.0 5791.0 5793.7 4149.0 4162.2 4163.6 4191.6 4194.5 5979.4 5979.7 6000.1 6041.8 6057.8 5664.9 5748.7 5933.5 5935.0 5938.5 5854.9 5863.4 5865.1 5928.5 5952.0 5728.3 5738.4 5741.5 5744.1 5751.1 5873.5 5909.2 5914.8 5916.1 5919.8 5580.8 5755.9 5778.2 5787.5 5789.9 15:17:39 INFO - PROCESS | 5379 | 15:17:39 INFO - PROCESS | 5379 | [#5] yui.html Cycles:180 Average:11434.83 Median:516.99 stddev:13410.54 (2594.0%) stddev-sans-first:13423.04 15:17:39 INFO - PROCESS | 5379 | Values: 504.7 585.2 642.9 648.8 649.9 10745.2 11018.8 11063.6 11065.8 11082.6 10302.2 11457.9 11471.1 11488.4 11488.4 768.2 778.8 788.8 799.9 801.0 785.0 789.3 789.9 792.5 795.7 523.7 526.1 526.6 533.0 536.1 514.5 519.5 520.3 523.3 524.0 376.2 377.1 379.0 379.2 381.8 11378.9 11416.4 11459.7 11473.3 11962.7 11236.6 11297.4 11436.0 11535.4 11681.6 9011.5 9029.3 9063.0 9173.4 9254.9 2730.9 2937.2 2948.3 2949.0 2956.7 37966.4 39150.2 40387.6 41272.8 41275.4 8827.9 8843.6 8857.1 8862.0 8939.6 15447.8 15569.1 15600.9 15604.1 15618.8 5647.1 5678.0 5757.5 5773.9 5778.2 3048.3 3090.4 3117.4 3118.6 3242.8 2427.2 2517.5 2528.8 2533.1 2543.1 464.6 465.1 466.7 470.4 471.9 472.8 493.3 522.5 522.6 534.7 7090.0 7198.6 7320.0 7430.0 7532.0 428.7 506.3 520.6 530.9 532.2 3414.2 3456.9 3457.6 3543.2 3588.5 46631.8 47499.5 47611.0 47842.5 47858.0 42390.8 42852.0 43229.8 43322.4 44015.1 39115.0 39210.0 39522.8 39659.6 39714.2 6788.0 6840.9 6926.8 7030.0 7121.9 29037.7 30462.4 30766.0 31244.5 31442.2 35479.5 35750.5 35982.8 38165.0 38548.6 7716.9 7919.9 8109.0 8173.6 8264.9 8852.9 8951.5 8953.8 9058.7 9218.5 8671.0 8821.7 8836.2 8836.7 8942.9 8218.8 8381.9 8554.9 8585.4 8699.7 8181.2 8386.3 8571.2 8583.2 8677.6 7592.9 7626.4 7647.7 7677.4 7775.2 7653.2 7677.9 7723.2 7992.6 8036.4 15:17:39 INFO - PROCESS | 5379 | -------- Summary: end -------- 15:17:39 INFO - PROCESS | 5379 | 15:17:39 INFO - PROCESS | 5379 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:39 INFO - PROCESS | 5379 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:39 INFO - PROCESS | 5379 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:39 INFO - PROCESS | 5379 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:39 INFO - PROCESS | 5379 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:39 INFO - PROCESS | 5379 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:39 INFO - PROCESS | 5379 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:39 INFO - PROCESS | 5379 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:39 INFO - TEST-INFO | 5379: exit 0 15:17:39 INFO - TEST-OK | dromaeo_css | took 1114207ms 15:17:39 INFO - TEST-START | kraken 15:17:39 INFO - operating with platform_type : linux_ 15:17:39 INFO - Initialising browser for kraken test... 15:17:39 INFO - TEST-INFO | started process 5615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBPqo4f/profile http://localhost:34811/getInfo.html) 15:17:44 INFO - PROCESS | 5615 | 15:17:44 INFO - PROCESS | 5615 | (process:5685): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:17:44 INFO - PROCESS | 5615 | __metrics Screen width/height:1600/1200 15:17:44 INFO - PROCESS | 5615 | colorDepth:24 15:17:44 INFO - PROCESS | 5615 | Browser inner width/height: 1024/697 15:17:44 INFO - PROCESS | 5615 | __metrics 15:17:45 ERROR - PROCESS | 5615 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:17:45 INFO - PROCESS | 5615 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:45 INFO - PROCESS | 5615 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:45 INFO - PROCESS | 5615 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:45 INFO - PROCESS | 5615 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:45 INFO - PROCESS | 5615 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:45 INFO - PROCESS | 5615 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:45 INFO - PROCESS | 5615 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:45 INFO - PROCESS | 5615 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:45 INFO - PROCESS | 5615 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:17:46 INFO - TEST-INFO | 5615: exit 0 15:17:46 INFO - Browser initialized. 15:17:46 INFO - Running cycle 1/1 for kraken test... 15:17:46 INFO - TEST-INFO | started process 5737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBPqo4f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:48 INFO - PROCESS | 5737 | 15:17:48 INFO - PROCESS | 5737 | (process:5794): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:17:58 INFO - PROCESS | 5737 | RSS: Main: 158990336 15:17:58 INFO - PROCESS | 5737 | 15:18:01 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34811/tests/kraken/driver.html?testName=audio-beat-detection) 15:18:01 INFO - PROCESS | 5737 | RSS: Main: 165158912 15:18:01 INFO - PROCESS | 5737 | 15:18:04 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34811/tests/kraken/driver.html?testName=audio-dft) 15:18:05 INFO - PROCESS | 5737 | RSS: Main: 168910848 15:18:05 INFO - PROCESS | 5737 | 15:18:08 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34811/tests/kraken/driver.html?testName=audio-fft) 15:18:08 INFO - PROCESS | 5737 | RSS: Main: 160501760 15:18:08 INFO - PROCESS | 5737 | 15:18:10 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34811/tests/kraken/driver.html?testName=audio-oscillator) 15:18:11 INFO - PROCESS | 5737 | RSS: Main: 160768000 15:18:11 INFO - PROCESS | 5737 | 15:18:13 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34811/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:18:14 INFO - PROCESS | 5737 | RSS: Main: 162058240 15:18:14 INFO - PROCESS | 5737 | 15:18:17 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34811/tests/kraken/driver.html?testName=imaging-darkroom) 15:18:18 INFO - PROCESS | 5737 | RSS: Main: 162455552 15:18:18 INFO - PROCESS | 5737 | 15:18:21 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34811/tests/kraken/driver.html?testName=imaging-desaturate) 15:18:22 INFO - PROCESS | 5737 | RSS: Main: 161492992 15:18:22 INFO - PROCESS | 5737 | 15:18:25 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34811/tests/kraken/driver.html?testName=json-parse-financial) 15:18:25 INFO - PROCESS | 5737 | RSS: Main: 162975744 15:18:25 INFO - PROCESS | 5737 | 15:18:27 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34811/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:18:28 INFO - PROCESS | 5737 | RSS: Main: 163561472 15:18:28 INFO - PROCESS | 5737 | 15:18:30 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34811/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:18:30 INFO - PROCESS | 5737 | RSS: Main: 161505280 15:18:30 INFO - PROCESS | 5737 | 15:18:32 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34811/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:18:33 INFO - PROCESS | 5737 | RSS: Main: 161923072 15:18:33 INFO - PROCESS | 5737 | 15:18:36 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:18:36 INFO - PROCESS | 5737 | RSS: Main: 161824768 15:18:36 INFO - PROCESS | 5737 | 15:18:39 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:18:39 INFO - PROCESS | 5737 | RSS: Main: 163651584 15:18:39 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | Cycle 1(1): loaded http://localhost:34811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34811/tests/kraken/driver.html?testName=ai-astar) 15:18:41 INFO - PROCESS | 5737 | RSS: Main: 163962880 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | __start_tp_report 15:18:41 INFO - PROCESS | 5737 | _x_x_mozilla_page_load 15:18:41 INFO - PROCESS | 5737 | _x_x_mozilla_page_load_details 15:18:41 INFO - PROCESS | 5737 | |i|pagename|runs| 15:18:41 INFO - PROCESS | 5737 | |0;ai-astar;115;111;116;116;118;125;116;117;115;115 15:18:41 INFO - PROCESS | 5737 | |1;audio-beat-detection;159;135;156;179;140;156;159;136;179;135 15:18:41 INFO - PROCESS | 5737 | |2;audio-dft;162;163;161;162;167;167;170;163;165;164 15:18:41 INFO - PROCESS | 5737 | |3;audio-fft;73;74;74;76;73;137;75;74;73;76 15:18:41 INFO - PROCESS | 5737 | |4;audio-oscillator;99;99;148;97;98;98;151;98;99;143 15:18:41 INFO - PROCESS | 5737 | |5;imaging-gaussian-blur;120;116;115;115;116;115;116;115;116;115 15:18:41 INFO - PROCESS | 5737 | |6;imaging-darkroom;149;148;148;147;147;150;148;150;148;148 15:18:41 INFO - PROCESS | 5737 | |7;imaging-desaturate;96;98;96;96;97;97;96;97;96;97 15:18:41 INFO - PROCESS | 5737 | |8;json-parse-financial;69;67;68;68;71;68;73;68;67;69 15:18:41 INFO - PROCESS | 5737 | |9;json-stringify-tinderbox;69;70;70;70;70;70;69;70;71;70 15:18:41 INFO - PROCESS | 5737 | |10;stanford-crypto-aes;85;86;86;88;87;87;85;85;97;86 15:18:41 INFO - PROCESS | 5737 | |11;stanford-crypto-ccm;125;141;126;126;130;125;127;128;139;134 15:18:41 INFO - PROCESS | 5737 | |12;stanford-crypto-pbkdf2;142;153;152;154;152;141;158;150;167;144 15:18:41 INFO - PROCESS | 5737 | |13;stanford-crypto-sha256-iterative;71;72;73;71;80;72;72;70;71;70 15:18:41 INFO - PROCESS | 5737 | __end_tp_report 15:18:41 INFO - PROCESS | 5737 | __start_cc_report 15:18:41 INFO - PROCESS | 5737 | _x_x_mozilla_cycle_collect,886 15:18:41 INFO - PROCESS | 5737 | __end_cc_report 15:18:41 INFO - PROCESS | 5737 | __startTimestamp1456528721967__endTimestamp 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | ------- Summary: start ------- 15:18:41 INFO - PROCESS | 5737 | Number of tests: 14 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.00 stddev:3.53 (3.0%) stddev-sans-first:3.71 15:18:41 INFO - PROCESS | 5737 | Values: 115.0 111.0 116.0 116.0 118.0 125.0 116.0 117.0 115.0 115.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:157.50 stddev:16.82 (10.7%) stddev-sans-first:17.72 15:18:41 INFO - PROCESS | 5737 | Values: 159.0 135.0 156.0 179.0 140.0 156.0 159.0 136.0 179.0 135.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:2.84 (1.7%) stddev-sans-first:2.87 15:18:41 INFO - PROCESS | 5737 | Values: 162.0 163.0 161.0 162.0 167.0 167.0 170.0 163.0 165.0 164.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:19.88 (26.9%) stddev-sans-first:20.90 15:18:41 INFO - PROCESS | 5737 | Values: 73.0 74.0 74.0 76.0 73.0 137.0 75.0 74.0 73.0 76.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#4] audio-oscillator Cycles:10 Average:113.00 Median:98.00 stddev:23.78 (24.3%) stddev-sans-first:24.67 15:18:41 INFO - PROCESS | 5737 | Values: 99.0 99.0 148.0 97.0 98.0 98.0 151.0 98.0 99.0 143.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.00 stddev:1.52 (1.3%) stddev-sans-first:0.53 15:18:41 INFO - PROCESS | 5737 | Values: 120.0 116.0 115.0 115.0 116.0 115.0 116.0 115.0 116.0 115.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 15:18:41 INFO - PROCESS | 5737 | Values: 149.0 148.0 148.0 147.0 147.0 150.0 148.0 150.0 148.0 148.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 15:18:41 INFO - PROCESS | 5737 | Values: 96.0 98.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 97.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:68.50 stddev:1.87 (2.7%) stddev-sans-first:1.99 15:18:41 INFO - PROCESS | 5737 | Values: 69.0 67.0 68.0 68.0 71.0 68.0 73.0 68.0 67.0 69.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 15:18:41 INFO - PROCESS | 5737 | Values: 69.0 70.0 70.0 70.0 70.0 70.0 69.0 70.0 71.0 70.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.50 stddev:3.58 (4.1%) stddev-sans-first:3.71 15:18:41 INFO - PROCESS | 5737 | Values: 85.0 86.0 86.0 88.0 87.0 87.0 85.0 85.0 97.0 86.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:129.00 stddev:5.90 (4.6%) stddev-sans-first:5.96 15:18:41 INFO - PROCESS | 5737 | Values: 125.0 141.0 126.0 126.0 130.0 125.0 127.0 128.0 139.0 134.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:152.50 stddev:7.82 (5.1%) stddev-sans-first:7.53 15:18:41 INFO - PROCESS | 5737 | Values: 142.0 153.0 152.0 154.0 152.0 141.0 158.0 150.0 167.0 144.0 15:18:41 INFO - PROCESS | 5737 | 15:18:41 INFO - PROCESS | 5737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:2.90 (4.0%) stddev-sans-first:3.04 15:18:41 INFO - PROCESS | 5737 | Values: 71.0 72.0 73.0 71.0 80.0 72.0 72.0 70.0 71.0 70.0 15:18:41 INFO - PROCESS | 5737 | -------- Summary: end -------- 15:18:41 INFO - PROCESS | 5737 | 15:18:42 INFO - PROCESS | 5737 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:18:42 INFO - PROCESS | 5737 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:18:42 INFO - PROCESS | 5737 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:18:42 INFO - PROCESS | 5737 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:18:42 INFO - PROCESS | 5737 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:18:42 INFO - PROCESS | 5737 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:18:42 INFO - PROCESS | 5737 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:18:42 INFO - TEST-INFO | 5737: exit 0 15:18:42 INFO - TEST-OK | kraken | took 63215ms 15:18:42 INFO - SUITE-END | took 1177s 15:18:43 INFO - Completed test suite (00:19:37) 15:18:43 INFO - Working with test: dromaeo_css 15:18:43 INFO - Generating results file: dromaeo_css 15:18:43 INFO - Working with test: kraken 15:18:43 INFO - Generating results file: kraken 15:18:43 INFO - javascript benchmark 15:18:43 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:18:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 15:18:43 INFO - process_Request line: dromaeo_css 6001.54 graph.html#tests=[[72,132,43]] 15:18:43 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:18:43 INFO - process_Request line: kraken 1568.00 graph.html#tests=[[232,132,43]] 15:18:43 INFO - RETURN: dromaeo_css: 6001.54 15:18:43 INFO - RETURN: kraken: 1568.00 15:18:43 INFO - javascript benchmark 15:18:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2630.237231202951, 2647.8940842366305, 2670.7596316331537, 2674.9999999999995, 2681.9597706034415, 4419.49175844778, 4545.954540454594, 4559.817607295704, 4569.634429245661, 4595.88510287243, 4521.638268938485, 4585.839495617654, 4586.587207151364, 4592.288195329721, 4637.768111594423, 4225.978870105645, 4227.217964676537, 4234.1955028544635, 4285.72849427608, 4322.13557288542, 4173.1862286854075, 4226.0, 4270.551592082833, 4271.850485233017, 4278.700490965633, 4207.347861081537, 4211.915761684749, 4218.388333691598, 4244.469441319835, 4246.851360202378, 4215.156968606291, 4215.852445164435, 4250.0437401584395, 4252.659787217046, 4270.316749320094, 4103.4870641169855, 4135.8966025849295, 4211.957880421218, 4225.577442255781, 4239.957600423987, 4397.31841564558, 4407.955920440819, 4417.425734654475, 4421.845235416745, 4452.265376212921, 4761.8095276188915, 4765.0, 4795.2807078938085, 4798.976005119987, 4848.5636292733825, 4747.145513807513, 4809.110314591777, 4859.757012149414, 4888.486708895586, 4947.777350019222, 4479.910401791946, 4489.483709373399, 4491.562699935989, 4509.4814096379005, 4520.615747661485, 4939.086269040239, 4945.159322915113, 4951.603871690256, 4954.8761280968265, 4988.0, 4639.420072490939, 4781.976090119527, 4814.807407703723, 4846.200376937836, 4869.391326084239, 4728.101660684459, 4846.733429661403, 4856.781444834991, 4881.95118048822, 4926.926096108561, 4785.186518291899, 4786.401699787527, 4787.138315103315, 4800.039992001543, 4831.637627177905, 4693.084848454519, 4801.95198048015, 4808.230683090758, 4831.130396528588, 4868.075065737569, 4112.465379500705, 4128.442660240889, 4129.545749967501, 4156.709030367845, 4165.437665915063, 3516.331896939573, 3636.5454318210222, 3636.890893273206, 3651.6165802590344, 3671.853125874935, 4192.664586833046, 4233.936490952638, 4241.575842415734, 4247.447831781848, 4273.893152671208, 4809.230523116355, 4851.708897466164, 4852.199387101159, 4872.293517439952, 4901.166801643729, 4156.25187466259, 4182.81177347014, 4192.937105943413, 4211.389348544505, 4223.239816832999, 4320.4383430153875, 4324.308110702273, 4327.480702315679, 4356.934645980313, 4367.47590289161, 4507.8196872124745, 4568.0407114505, 4569.13186494565, 4582.702124361973, 4608.470025946992, 4841.443234028132, 4914.5085491452, 4983.551480366785, 5016.172331565251, 5032.874178145576, 4621.6302695784925, 4660.790264438041, 4680.953190468052, 4680.976595117003, 4725.905481890274, 4658.208104622155, 4870.610351171827, 4876.073546026244, 4878.390201224847, 4915.090708218991, 4846.660733748604, 4848.418189817245, 4874.707517548958, 4902.534259245366, 4917.26241063829, 4559.338895860015, 4645.09420662981, 4696.506866778939, 4701.717896926195, 4747.905041899212, 4570.223062079521, 4677.087967846237, 4696.38946936896, 4697.177993851131, 4731.337612734289, 4499.077689073667, 4512.9548704513845, 4540.978279886999, 4543.6365090792, 4594.540545945512, 4743.264793956942, 4744.4069491313585, 4746.288056791371, 4772.427308722976, 4776.8566942991765, 4612.469565999953, 4657.0918670858855, 4668.996165824228, 4671.906561868812, 4706.576408123286], "unit": "score", "name": "dojo.html", "value": 4467.639696252696}, {"lowerIsBetter": false, "replicates": [470.5271202441548, 512.203523520925, 528.6722232216024, 540.5972550449916, 547.4689551135398, 32411.189720256974, 33043.834780826124, 33082.338353232924, 33119.503207451875, 33151.502727459076, 29367.412651746952, 29784.25539361517, 29830.55254171189, 29868.701312986865, 29941.401171976548, 7336.743213987498, 7485.288897554751, 7487.887681684779, 7490.063742032246, 7497.700091996314, 7498.850022999537, 7780.0, 7801.882971755428, 7822.530648161129, 7858.096318923312, 7746.341560967297, 7842.803929901769, 7883.526988380687, 7886.250806173404, 7887.290143887049, 7797.0, 7812.960935195344, 7832.530048197098, 7852.21477852216, 7852.842943141134, 7605.695772169107, 7785.649645765954, 7803.843923121506, 7817.101033381177, 7837.529748215125, 34203.0, 34374.312513749835, 34452.48321275183, 34707.30585388303, 34761.0, 2586.2887705880844, 2723.4280801031805, 2833.6316278883614, 2867.311845157147, 3398.5411969384313, 28038.0, 28655.14034578966, 28713.85643071771, 29526.409471810442, 29752.40495190084, 2791.9581206281923, 3438.9312213755834, 3451.706604938583, 3572.8928132156075, 3606.206634540397, 209117.0, 209228.0, 209726.0, 210066.0, 211894.0, 42257.0, 55267.0, 55677.44322556723, 55741.442585573626, 55746.72126639341, 41036.0, 41043.179136417704, 41228.79385603053, 41238.79380603078, 41359.1728165441, 12995.675108122372, 13123.803142952864, 13251.801222981663, 13287.601371958857, 13355.933220334031, 9795.657151999645, 9810.607575697035, 9842.50787460624, 9904.059114384121, 9913.206943444507, 13601.183928964294, 13610.931945340408, 13642.795358069638, 13792.172469651852, 13799.86200138006, 5466.262054622654, 5532.1425179097305, 5595.440455954454, 5600.27196464457, 5610.653443173691, 881.9118088191129, 957.5834511987308, 990.2177279948904, 1003.8556046107443, 1052.0899422000068, 26172.73827261703, 26297.34256643561, 26345.604815927778, 26364.736352636228, 26485.205443836716, 943.033390774448, 977.452626529146, 1000.7848312612823, 1001.9198464122853, 1029.351508549609, 13656.248906310248, 13757.931210343884, 13910.86089139116, 14107.083039602392, 14123.71752564943, 257717.0, 259009.0, 259926.0, 260903.0, 261871.0, 38491.61508384936, 38627.61372386297, 38637.80681096633, 38996.0, 39137.41293880594, 1197.581239860377, 1211.436681942883, 1228.827964085011, 1231.347385885482, 1234.8950339221267, 25127.0, 25940.481190376464, 26266.868665656548, 26302.0, 26759.331016724736, 40775.38836917508, 40952.79523602363, 41070.79464602658, 41151.58848411478, 41274.58725412707, 242226.0, 242489.0, 242949.0, 243775.0, 244216.0, 29727.70272297249, 29869.253268668457, 30577.23556911095, 30693.23266918345, 30733.846330768203, 39485.0, 39526.802365987984, 39596.604033960444, 39858.402123967586, 40042.1991560173, 33298.33403331968, 33886.491702624975, 34174.316513670085, 34241.486377703855, 34270.14324641904, 33622.327553448304, 33927.830360849024, 34160.31679366448, 34335.484967725, 34394.65605344014, 34660.65339346574, 35111.297774044884, 35658.28683426265, 36540.63459365479, 36592.26815463729, 27365.0, 30227.395452090394, 30977.845110774302, 31051.844740776152, 31109.377812444076, 23546.52906941886, 23767.286981390585, 23806.642900356856, 23889.163879264142, 24086.759132408453], "unit": "score", "name": "ext.html", "value": 16055.5276061988}, {"lowerIsBetter": false, "replicates": [332.9711192415436, 334.9866005359785, 339.3230505142242, 343.54651859545396, 345.9117924929143, 14423.278836058207, 14944.77582836257, 15508.069515829058, 15686.843131568681, 15785.13181775002, 14098.788518172236, 14153.363098660559, 14454.566363009126, 14502.0, 14630.122192668447, 4884.096442158203, 5118.0, 5118.718470484122, 5119.257707632391, 5126.5642420394315, 4656.767161641921, 5002.924956125661, 5088.465711100337, 5096.79612815487, 5113.642045056848, 5036.219385995177, 5041.218611115265, 5069.062223488648, 5071.847844564669, 5073.086844368012, 4827.686200396963, 4991.450940396553, 4999.500049994989, 5028.622853286018, 5052.9242061369105, 4479.932801007955, 4494.9325760113625, 4496.3705081288645, 4497.8425755098415, 4505.166544189303, 18144.727829082574, 18413.07934603278, 18590.44228673142, 18627.90686046561, 18633.254669813192, 1873.0447471789485, 1929.0644037641732, 1945.105251584273, 1948.4252145616936, 2253.5605556916407, 11864.881351186465, 12009.039276857831, 12088.758224835541, 12244.326562039085, 12550.623481295575, 1764.5676809181705, 1781.910904454772, 1793.4798908316573, 1808.5569035586366, 1819.4996375996575, 53106.46893531054, 53714.46285537173, 54158.0, 54193.0, 54434.18348724733, 9082.364234503653, 9115.134062264075, 9444.244460443148, 9459.716208513755, 9553.570089345996, 11963.222390544586, 11974.042076633848, 12001.819972700416, 12023.819642705366, 12081.697957551132, 6788.321167883172, 6852.074969879102, 7016.158061032709, 7112.786616401516, 7112.964435177791, 6683.465322774166, 6727.461803055744, 6818.590884546943, 6819.215790184192, 6823.454123670094, 5540.335159780852, 5655.462731040545, 5702.600817942787, 5721.141828725641, 5757.85605359861, 1688.6200604863807, 1721.5265801904577, 1726.3612463388627, 1734.9219285132199, 1740.4082611911758, 912.056022017209, 929.4051806843626, 937.4234845570062, 938.3244064273712, 984.0897170117613, 15145.772813407808, 15266.847331526764, 15296.005759625588, 15492.07047577149, 15718.842811571738, 863.926566241864, 894.2354287084579, 934.514052692596, 939.234523863063, 970.2238209432426, 8990.021541585138, 9089.0, 9140.771480713036, 9239.937407198124, 9304.627814887464, 346037.0, 358159.0, 361333.0, 363666.0, 373940.0, 42220.73337799871, 48409.27386089211, 50230.24654630184, 57835.42164578385, 58647.120293195636, 924.7503174142944, 930.9860352094724, 951.7763325618474, 953.3660116022767, 956.660385563115, 13756.793648095087, 14034.508792192633, 14048.438062477795, 14359.856401435853, 14468.565943021726, 28164.43671126607, 29197.270068247613, 29485.26286842846, 30414.087577372713, 30590.08229753111, 34863.12842178966, 36451.0, 37678.05804854791, 37725.245495089395, 37765.4335184967, 6578.342165783383, 6752.189737231563, 6820.965895170492, 6821.420179284618, 6868.381845633917, 9036.45781253127, 10762.51568679427, 10812.729681757704, 10978.560857565928, 10985.945070274916, 9320.860187097334, 9469.66856160031, 9559.23526117895, 9752.756181095529, 9754.170895473964, 9294.488803115893, 9314.6274149036, 9332.253419726541, 9368.110029547182, 9754.414735115915, 10052.597896084368, 10217.846732299171, 10256.53845576936, 10328.845067324146, 10563.63027294041, 6619.205695316593, 6687.398134167948, 6711.161104861892, 6835.111435513351, 6920.100386949664, 9234.076592340713, 9456.669016584387, 9571.138597526256, 9666.0, 9672.322937394314], "unit": "score", "name": "jquery.html", "value": 7657.179778807575}, {"lowerIsBetter": false, "replicates": [1257.2582176515857, 1340.530814215025, 1420.9130015538115, 1681.9495415137542, 1684.6125391160026, 5543.667379957195, 6516.0877477153235, 6579.407853293203, 6737.595744255348, 6756.797296081119, 6662.7668031618905, 6696.765613203539, 6699.4975376846805, 6736.629485378302, 6768.830779230521, 2018.2633338831295, 2033.5119571302928, 2034.0948278016251, 2060.206820374152, 2060.4230815371643, 1963.3520938090396, 1997.2410484016054, 1997.7702564205158, 2028.9855072463768, 2029.1781828359465, 1984.8809071455687, 1995.950101247466, 1997.6304383689064, 2003.4089943466713, 2010.2059686423854, 2035.0740413112073, 2046.8669536480156, 2047.2322878920404, 2049.846261530384, 2050.3643870400224, 1990.6217818614416, 2009.9598008039757, 2024.4938765308673, 2029.512916899948, 2030.8984550772402, 6777.423918966893, 6873.931260687379, 6891.207511136183, 6899.413549848218, 6906.06768086307, 4042.757434553936, 4140.420341152241, 4150.481189851269, 4153.813078411479, 4158.854440094582, 2559.923202303934, 2628.5531459651907, 2639.4457163995585, 2657.50836095323, 2704.756571908538, 796.7410591557767, 803.7869964459423, 803.8995125609299, 813.2639960835394, 819.635262308273, 9030.593623286968, 9056.184943355129, 9118.77203069922, 9128.771780705469, 9147.81704365909, 3717.368047431943, 3768.9811550942068, 3835.76985380878, 3836.07934095815, 3842.538895332578, 7567.091948966159, 7567.735129270559, 7578.09062912454, 7602.353799927068, 7647.388208943271, 4137.069159439162, 4144.461220041375, 4170.395292682544, 4185.24665560196, 4199.643030342455, 3099.5660607514965, 3761.1725420407465, 3780.8298626561873, 3798.6771124454176, 3828.7511311764647, 3282.7373810095137, 3300.8184549849507, 3360.798352098882, 3387.4072037393357, 3390.6439823818637, 1077.4666540062562, 1078.6278733836814, 1080.3140006096185, 1081.4214395298477, 1091.7772095253208, 874.8687696845524, 884.0319849764497, 884.4958373726914, 900.446225571269, 965.7875267441152, 6099.085137229363, 6143.6928153593035, 6185.319614842364, 6192.907106393408, 6200.906986395207, 1001.1440218613127, 1026.097034609539, 1045.534737042009, 1045.7699306152633, 1052.7947050325113, 4988.9501104988485, 5042.621803364762, 5084.8220312288895, 5087.796488140507, 5103.744812759347, 7722.806929826799, 7977.282044616012, 8013.11855695873, 8171.264586187272, 8295.585220738938, 8094.51432914027, 8116.6347514362, 8122.796930076677, 8166.142555031755, 8180.877286840702, 6411.67941602918, 6485.254195767453, 6513.2184137902805, 6530.0, 6531.183602049744, 5979.641221526722, 6133.8466538335115, 6138.508919286357, 6155.599886007395, 6167.290761562478, 7212.71149154028, 7226.963865180641, 7314.268573142856, 7320.194778574246, 7396.55620662762, 7343.48595598303, 7473.738419155304, 7510.774676759706, 7546.584937828472, 7567.848643027219, 4753.548412900769, 5381.811636592701, 5640.943590564042, 5695.772169113189, 5714.3714191438075, 6296.653684047238, 6308.549033722178, 6325.620462772248, 6337.207849018872, 6350.301466838551, 5710.086386178192, 5755.65466072037, 5811.970940145272, 5896.911546326723, 5970.283565972111, 5539.279893613804, 5670.319561652628, 5745.827625171251, 5752.827415177551, 5755.482006619424, 5902.498287645598, 6058.3335833057445, 6061.7575296987625, 6094.603850749864, 6240.251169859464, 5596.272484576979, 5661.264035675335, 5662.065759149694, 5675.0, 5676.687782171855, 5862.237909071793, 5912.822615321547, 5913.970430147821, 5914.467697907209, 5924.377940316204], "unit": "score", "name": "mootools.html", "value": 3894.1469998872635}, {"lowerIsBetter": false, "replicates": [290.43365437397074, 296.2445763303575, 299.94001199760055, 301.9698030196982, 305.3922693839259, 5460.208269800876, 5520.641158324706, 5551.72241387931, 5589.580781441387, 5693.487586117249, 5531.170324451325, 5566.693831839248, 5593.077142271521, 5601.915971260434, 5605.831825045245, 4048.67610591152, 4153.190127925056, 4176.812043458051, 4235.57644235577, 4248.660107191417, 4203.831846726127, 4205.600467955539, 4208.558101399355, 4211.747295162285, 4232.619064284214, 4165.958340416587, 4176.1230141670285, 4176.143890502455, 4188.874333769992, 4189.790510474464, 4127.339625659895, 4179.26862799009, 4188.560201178862, 4189.28782107041, 4197.0, 3611.855525778992, 3622.3841946868833, 3624.4382120771324, 3627.0207044097947, 3627.038834708804, 5329.387120481156, 5339.893202135974, 5342.599305052097, 5346.41189469162, 5351.117065684196, 4510.233260345716, 4800.159972004885, 4808.2547205183255, 4813.08551375241, 4816.397950256218, 5757.136429535562, 5770.336411312669, 5787.33445653751, 5805.88388232233, 5817.7382017809305, 3756.793376364299, 3758.868439604628, 3766.2090960898245, 3771.283456143324, 3774.3772277574167, 6036.577439579231, 6117.5717699761035, 6123.142760013601, 6127.44852963231, 6127.877442451126, 3893.0851249956236, 3896.4350169225304, 3914.432407300925, 3915.8237879295502, 3916.4712763777097, 3960.544537378181, 3964.365701487748, 3965.40518922164, 3965.7620542767527, 3965.9688480994573, 4608.147492713859, 4657.604103651228, 4662.487126416091, 4681.0, 4697.530246975343, 5771.105478650816, 5798.072308430631, 5803.47768700819, 5820.912686309709, 5822.1266809978, 1422.3599380278708, 1438.841727409984, 1444.6677264229286, 1446.146773403697, 1448.0732331307972, 899.7930475990559, 940.3464592108419, 942.820864035831, 958.712386284112, 969.1471505075489, 5065.873353166126, 5069.670471419346, 5072.442031376546, 5072.67027643202, 5075.289459475676, 6053.092036194606, 6058.0, 6059.27288725347, 6064.06007068905, 6064.545159113084, 5045.672031317952, 5049.0, 5051.570616497565, 5054.848354549369, 5056.089903817275, 3180.6183258008723, 3268.67313268676, 3275.4922986937063, 3276.5904261967253, 3277.082416923265, 5722.341930677942, 5758.395368486333, 5758.856028599319, 5765.279340082489, 5787.102999035156, 6277.497800175975, 6280.811575652738, 6291.842703932438, 6316.399942005502, 6316.842078948063, 5747.885042299131, 5748.338941021752, 5750.3099628044065, 5762.193292938992, 5773.971130144322, 5827.94172058274, 5917.082852157922, 6058.787942421994, 6090.878182436238, 6102.420270074336, 5822.505087067647, 5981.491573216325, 5985.221921150397, 5986.3115741688525, 6004.129401236709, 5684.71576421169, 5753.453421924911, 5786.0, 5791.0, 5793.652380857162, 4149.0, 4162.188373267305, 4163.583641635933, 4191.622753952159, 4194.496660400771, 5979.431953964367, 5979.671118088547, 6000.129981152796, 6041.758329666764, 6057.848553786191, 5664.886702266014, 5748.741306641127, 5933.495652869382, 5935.0207215808905, 5938.465538101592, 5854.853628659318, 5863.442972917566, 5865.090910908816, 5928.466438020599, 5952.0476723724, 5728.283964504437, 5738.426157384228, 5741.5406767459335, 5744.109663002241, 5751.051076572486, 5873.471387575139, 5909.23179986599, 5914.792982245601, 5916.142159386951, 5919.792807251725, 5580.832575022756, 5755.913661295168, 5778.248827652378, 5787.508061814793, 5789.913151302818], "unit": "score", "name": "prototype.html", "value": 4315.233770187681}, {"lowerIsBetter": false, "replicates": [504.7249249159208, 585.180746954264, 642.9485641148708, 648.8053583924822, 649.8895187818074, 10745.247832651708, 11018.834717479243, 11063.612773552928, 11065.834012489799, 11082.556697732081, 10302.175825933908, 11457.885421145786, 11471.139664525152, 11488.36813975231, 11488.425578721073, 768.2202564397141, 778.781941056505, 788.7988562916477, 799.8840168175611, 800.951942883426, 784.9568273744942, 789.3093543149744, 789.8617741895174, 792.528445574882, 795.6976348987406, 523.6988731479396, 526.1240035341172, 526.6208330002411, 532.9706866122361, 536.1020291012538, 514.4957941217609, 519.4779246856884, 520.3131865936965, 523.2543625333922, 523.9764210610513, 376.23999520967766, 377.06487909983395, 379.02779370913794, 379.2358397828378, 381.7823840410967, 11378.886211137866, 11416.42917854104, 11459.656210313704, 11473.311601303949, 11962.700932476671, 11236.550537978472, 11297.435128243555, 11436.027937625311, 11535.365554894477, 11681.591144309994, 9011.504367259799, 9029.322800789902, 9062.954685226532, 9173.403728757676, 9254.86117708235, 2730.931726706828, 2937.1922721251826, 2948.3366242595457, 2948.9852550737323, 2956.659984101813, 37966.43050354247, 39150.2169956605, 40387.59612403897, 41272.79363603193, 41275.380869286986, 8827.867581986275, 8843.60203790831, 8857.11428857122, 8861.955690221508, 8939.553022348857, 15447.845521544641, 15569.143697096768, 15600.92199538995, 15604.141772202638, 15618.843811561967, 5647.096464565732, 5677.971610141923, 5757.481826635623, 5773.942260577424, 5778.219940308089, 3048.314129320885, 3090.3973725123833, 3117.3921085388583, 3118.6413562440157, 3242.789218700777, 2427.235420842429, 2517.5090857282653, 2528.797696184301, 2533.0880882882147, 2543.122622695167, 464.63758268550583, 465.14645625277996, 466.7269647256325, 470.3556128104519, 471.94049359188153, 472.7919715325246, 493.3339991012105, 522.454035532869, 522.5636593444441, 534.7272890825707, 7090.0, 7198.640067996579, 7320.0, 7430.038127040252, 7531.962340188264, 428.71062033127515, 506.2709698034818, 520.6199474383722, 530.933633295838, 532.1698150884632, 3414.197663549064, 3456.89109197267, 3457.619661837196, 3543.167355671415, 3588.4796704477703, 46631.766841165576, 47499.525004750205, 47611.0, 47842.5215747845, 47858.0, 42390.78804605957, 42852.0, 43229.783851080545, 43322.35016474756, 44015.11969760651, 39115.0, 39210.0, 39522.80238598789, 39659.60340396617, 39714.2057158861, 6788.0, 6840.863182736417, 6926.826829329307, 7030.0, 7121.893171602326, 29037.7096229035, 30462.390752185274, 30766.0, 31244.531332030492, 31442.21394465157, 35479.467807982386, 35750.4637430444, 35982.8200858994, 38165.04587385338, 38548.6145138545, 7716.884246736416, 7919.881201782093, 8109.026916770025, 8173.5504547250475, 8264.876026859722, 8852.867206991772, 8951.507667078373, 8953.776155596162, 9058.728238152866, 9218.539073046455, 8670.956645216733, 8821.691240806542, 8836.160564746338, 8836.690715825172, 8942.86585701202, 8218.794530136794, 8381.874271885805, 8554.91445085566, 8585.399022068645, 8699.739007829776, 8181.227833558262, 8386.329093672613, 8571.22858942698, 8583.197434359587, 8677.609507572048, 7592.8861067085145, 7626.389888808771, 7647.655855486405, 7677.424193185645, 7775.22247775218, 7653.158152603098, 7677.9232207677205, 7723.189065148304, 7992.600369981594, 8036.357091432555], "unit": "score", "name": "yui.html", "value": 5062.247923974945}], "name": "dromaeo_css", "value": 6001.54035453472}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 116.0, 116.0, 118.0, 125.0, 116.0, 117.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.4}, {"lowerIsBetter": true, "replicates": [159.0, 135.0, 156.0, 179.0, 140.0, 156.0, 159.0, 136.0, 179.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 153.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 162.0, 167.0, 167.0, 170.0, 163.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 74.0, 76.0, 73.0, 137.0, 75.0, 74.0, 73.0, 76.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [99.0, 99.0, 148.0, 97.0, 98.0, 98.0, 151.0, 98.0, 99.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 113.0}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 115.0, 115.0, 116.0, 115.0, 116.0, 115.0, 116.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.9}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 148.0, 147.0, 147.0, 150.0, 148.0, 150.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 68.0, 71.0, 68.0, 73.0, 68.0, 67.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 68.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0, 71.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 88.0, 87.0, 87.0, 85.0, 85.0, 97.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [125.0, 141.0, 126.0, 126.0, 130.0, 125.0, 127.0, 128.0, 139.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.1}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 152.0, 154.0, 152.0, 141.0, 158.0, 150.0, 167.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 73.0, 71.0, 80.0, 72.0, 72.0, 70.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.2}], "name": "kraken", "value": 1568.0000000000002}]} 15:18:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1568.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6001.54"}}} 15:18:43 INFO - Return code: 0 15:18:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:18:43 ERROR - # TBPL SUCCESS # 15:18:43 INFO - Running post-action listener: _resource_record_post_action 15:18:43 INFO - Running post-run listener: _resource_record_post_run 15:18:44 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532004864; Read time: 36; Write time: 424872 15:18:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233541632; Read time: 0; Write time: 278884 15:18:44 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298463232; Read time: 36; Write time: 145988 15:18:44 INFO - Running post-run listener: _upload_blobber_files 15:18:44 INFO - Blob upload gear active. 15:18:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:18:44 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 15:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:18:44 INFO - (blobuploader) - INFO - Open directory for files ... 15:18:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:18:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:18:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:18:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:18:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:18:45 INFO - (blobuploader) - INFO - Done attempting. 15:18:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:18:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:18:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:18:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:18:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:18:46 INFO - (blobuploader) - INFO - Done attempting. 15:18:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:18:46 INFO - Return code: 0 15:18:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:18:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:18:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5aef47d992122d231cd928f3a9f03facc2694435c18be6444c8bd04bf1932f40d6b2043d139372a02b79274a363a2d808048aa0bfb30872921d6915732e4ffb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aca8a23a06e12973eb728702bdff748a7cb8ab337e0ca99c640d47c51569b628ccae99030e5a3c762f5524e01521d2e8950e66097a5ecf483f8d9614d2f4d324"} 15:18:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:18:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:18:46 INFO - Contents: 15:18:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5aef47d992122d231cd928f3a9f03facc2694435c18be6444c8bd04bf1932f40d6b2043d139372a02b79274a363a2d808048aa0bfb30872921d6915732e4ffb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aca8a23a06e12973eb728702bdff748a7cb8ab337e0ca99c640d47c51569b628ccae99030e5a3c762f5524e01521d2e8950e66097a5ecf483f8d9614d2f4d324"} 15:18:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:18:46 INFO - Copying logs to upload dir... 15:18:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:18:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.470675 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-26 15:18:46.346371) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 15:18:46.349645) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5aef47d992122d231cd928f3a9f03facc2694435c18be6444c8bd04bf1932f40d6b2043d139372a02b79274a363a2d808048aa0bfb30872921d6915732e4ffb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aca8a23a06e12973eb728702bdff748a7cb8ab337e0ca99c640d47c51569b628ccae99030e5a3c762f5524e01521d2e8950e66097a5ecf483f8d9614d2f4d324"} build_url:https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/aVyTFi27RaOzaN__hMAsKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5aef47d992122d231cd928f3a9f03facc2694435c18be6444c8bd04bf1932f40d6b2043d139372a02b79274a363a2d808048aa0bfb30872921d6915732e4ffb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aca8a23a06e12973eb728702bdff748a7cb8ab337e0ca99c640d47c51569b628ccae99030e5a3c762f5524e01521d2e8950e66097a5ecf483f8d9614d2f4d324"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 15:18:46.377020) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:18:46.377398) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456527035.394018-1134691151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:18:46.461073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 15:18:46.461390) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 15:18:46.461675) ========= ========= Total master_lag: 0.28 =========